builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0291 starttime: 1484420472.07 results: success (0) buildid: 20170114093924 builduid: b4c17f0c37334b45b6dd28a587fc5bd9 revision: 5ce3882eec21be3a70e4afc050959ca2f76bfa76 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-14 11:01:12.071268) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-14 11:01:12.071720) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-14 11:01:12.071992) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-14 11:01:12.098710) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-14 11:01:12.099100) ========= 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.7EebYWXfGg/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.yQbYWeEOSN/Listeners TMPDIR=/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-14 11:01:12-- 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% 137M=0s 2017-01-14 11:01:12 (137 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.094211 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-14 11:01:12.220783) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-14 11:01:12.221136) ========= 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.7EebYWXfGg/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.yQbYWeEOSN/Listeners TMPDIR=/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.025368 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-14 11:01:12.269452) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-14 11:01:12.272852) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5ce3882eec21be3a70e4afc050959ca2f76bfa76 --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 5ce3882eec21be3a70e4afc050959ca2f76bfa76 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7EebYWXfGg/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.yQbYWeEOSN/Listeners TMPDIR=/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-14 11:01:12,370 truncating revision to first 12 chars 2017-01-14 11:01:12,370 Setting DEBUG logging. 2017-01-14 11:01:12,370 attempt 1/10 2017-01-14 11:01:12,370 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5ce3882eec21?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-14 11:01:14,658 unpacking tar archive at: mozilla-central-5ce3882eec21/testing/mozharness/ program finished with exit code 0 elapsedTime=2.547988 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-14 11:01:14.844291) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-14 11:01:14.847671) ========= script_repo_revision: 5ce3882eec21be3a70e4afc050959ca2f76bfa76 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-14 11:01:14.848091) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-14 11:01:14.848362) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-14 11:01:14.868317) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-01-14 11:01:14.868725) ========= /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.7EebYWXfGg/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.yQbYWeEOSN/Listeners TMPDIR=/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 11:01:15 INFO - MultiFileLogger online at 20170114 11:01:15 in /builds/slave/test 11:01:15 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 11:01:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:01:15 INFO - {'append_to_log': False, 11:01:15 INFO - 'base_work_dir': '/builds/slave/test', 11:01:15 INFO - 'blob_upload_branch': 'Firefox', 11:01:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:01:15 INFO - 'branch': 'Firefox', 11:01:15 INFO - 'buildbot_json_path': 'buildprops.json', 11:01:15 INFO - 'config_files': ('talos/mac_config.py',), 11:01:15 INFO - 'default_actions': ('clobber', 11:01:15 INFO - 'read-buildbot-config', 11:01:15 INFO - 'download-and-extract', 11:01:15 INFO - 'populate-webroot', 11:01:15 INFO - 'create-virtualenv', 11:01:15 INFO - 'install', 11:01:15 INFO - 'run-tests'), 11:01:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:01:15 INFO - 'download_minidump_stackwalk': True, 11:01:15 INFO - 'download_symbols': 'ondemand', 11:01:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:01:15 INFO - 'tooltool.py': '/tools/tooltool.py', 11:01:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:01:15 INFO - '/tools/misc-python/virtualenv.py')}, 11:01:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:01:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:01:15 INFO - 'installer_path': 'installer.exe', 11:01:15 INFO - 'log_level': 'info', 11:01:15 INFO - 'log_name': 'talos', 11:01:15 INFO - 'log_to_console': True, 11:01:15 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:01:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:01:15 INFO - 'opt_config_files': (), 11:01:15 INFO - 'pip_index': False, 11:01:15 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:01:15 INFO - 'cmd': ('bash', 11:01:15 INFO - '-c', 11:01:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:01:15 INFO - 'enabled': True, 11:01:15 INFO - 'halt_on_failure': False, 11:01:15 INFO - 'name': 'check_screen_resolution'},), 11:01:15 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:01:15 INFO - 'cmd': ('bash', 11:01:15 INFO - '-c', 11:01:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:01:15 INFO - 'enabled': True, 11:01:15 INFO - 'halt_on_failure': False, 11:01:15 INFO - 'name': 'check_screen_resolution'},), 11:01:15 INFO - 'run_cmd_checks_enabled': True, 11:01:15 INFO - 'sps_profile': False, 11:01:15 INFO - 'sps_profile_interval': 0, 11:01:15 INFO - 'suite': 'dromaeojs-e10s', 11:01:15 INFO - 'system_bits': '32', 11:01:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:01:15 INFO - 'title': 't-yosemite-r7-0291', 11:01:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:01:15 INFO - 'use_talos_json': True, 11:01:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:01:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:01:15 INFO - 'work_dir': 'build'} 11:01:15 INFO - [mozharness: 2017-01-14 19:01:15.072169Z] Running clobber step. 11:01:15 INFO - Running pre-action listener: _resource_record_pre_action 11:01:15 INFO - Running main action method: clobber 11:01:15 INFO - rmtree: /builds/slave/test/build 11:01:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:01:17 INFO - Running post-action listener: _resource_record_post_action 11:01:17 INFO - [mozharness: 2017-01-14 19:01:17.445451Z] Finished clobber step (success) 11:01:17 INFO - [mozharness: 2017-01-14 19:01:17.445579Z] Running read-buildbot-config step. 11:01:17 INFO - Running pre-action listener: _resource_record_pre_action 11:01:17 INFO - Running main action method: read_buildbot_config 11:01:17 INFO - Using buildbot properties: 11:01:17 INFO - { 11:01:17 INFO - "project": "", 11:01:17 INFO - "product": "firefox", 11:01:17 INFO - "script_repo_revision": "production", 11:01:17 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 11:01:17 INFO - "repository": "", 11:01:17 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 11:01:17 INFO - "buildid": "20170114093924", 11:01:17 INFO - "pgo_build": "False", 11:01:17 INFO - "basedir": "/builds/slave/test", 11:01:17 INFO - "buildnumber": 13, 11:01:17 INFO - "slavename": "t-yosemite-r7-0291", 11:01:17 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 11:01:17 INFO - "platform": "yosemite_r7", 11:01:17 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 11:01:17 INFO - "branch": "mozilla-central", 11:01:17 INFO - "repo_path": "mozilla-central", 11:01:17 INFO - "revision": "5ce3882eec21be3a70e4afc050959ca2f76bfa76", 11:01:17 INFO - "stage_platform": "macosx64", 11:01:17 INFO - "builduid": "b4c17f0c37334b45b6dd28a587fc5bd9", 11:01:17 INFO - "slavebuilddir": "test" 11:01:17 INFO - } 11:01:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/IOPa4sRRToGbahjHImyaBw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 11:01:17 INFO - Running post-action listener: _resource_record_post_action 11:01:17 INFO - [mozharness: 2017-01-14 19:01:17.449569Z] Finished read-buildbot-config step (success) 11:01:17 INFO - [mozharness: 2017-01-14 19:01:17.449714Z] Running download-and-extract step. 11:01:17 INFO - Running pre-action listener: _resource_record_pre_action 11:01:17 INFO - Running main action method: download_and_extract 11:01:17 INFO - mkdir: /builds/slave/test/build/tests 11:01:17 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')]} 11:01:17 INFO - trying https://queue.taskcluster.net/v1/task/IOPa4sRRToGbahjHImyaBw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 11:01:17 INFO - Downloading https://queue.taskcluster.net/v1/task/IOPa4sRRToGbahjHImyaBw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 11:01:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IOPa4sRRToGbahjHImyaBw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 11:01:18 INFO - Downloaded 1199 bytes. 11:01:18 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 11:01:18 INFO - Using the following test package requirements: 11:01:18 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 11:01:18 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 11:01:18 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 11:01:18 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 11:01:18 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 11:01:18 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 11:01:18 INFO - u'jsshell-mac.zip'], 11:01:18 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 11:01:18 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 11:01:18 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 11:01:18 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 11:01:18 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 11:01:18 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 11:01:18 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 11:01:18 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 11:01:18 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 11:01:18 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 11:01:18 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 11:01:18 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:01:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IOPa4sRRToGbahjHImyaBw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 11:01:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IOPa4sRRToGbahjHImyaBw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:01:18 INFO - Fetch https://queue.taskcluster.net/v1/task/IOPa4sRRToGbahjHImyaBw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 11:01:19 INFO - Expected file size: 16319062 11:01:19 INFO - Obtained file size: 16319062 11:01:26 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 11:01:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IOPa4sRRToGbahjHImyaBw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 11:01:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IOPa4sRRToGbahjHImyaBw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:01:26 INFO - Fetch https://queue.taskcluster.net/v1/task/IOPa4sRRToGbahjHImyaBw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 11:01:27 INFO - Expected file size: 16319062 11:01:27 INFO - Obtained file size: 16319062 11:01:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IOPa4sRRToGbahjHImyaBw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 11:01:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IOPa4sRRToGbahjHImyaBw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 11:01:33 INFO - Fetch https://queue.taskcluster.net/v1/task/IOPa4sRRToGbahjHImyaBw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 11:01:34 INFO - Expected file size: 14403463 11:01:34 INFO - Obtained file size: 14403463 11:01:35 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')]} 11:01:35 INFO - trying https://queue.taskcluster.net/v1/task/IOPa4sRRToGbahjHImyaBw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 11:01:35 INFO - Downloading https://queue.taskcluster.net/v1/task/IOPa4sRRToGbahjHImyaBw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 11:01:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IOPa4sRRToGbahjHImyaBw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 11:01:37 INFO - Downloaded 70116437 bytes. 11:01:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IOPa4sRRToGbahjHImyaBw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 11:01:37 INFO - mkdir: /builds/slave/test/properties 11:01:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:01:37 INFO - Writing to file /builds/slave/test/properties/build_url 11:01:37 INFO - Contents: 11:01:37 INFO - build_url:https://queue.taskcluster.net/v1/task/IOPa4sRRToGbahjHImyaBw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 11:01:38 INFO - Running post-action listener: _resource_record_post_action 11:01:38 INFO - Running post-action listener: set_extra_try_arguments 11:01:38 INFO - [mozharness: 2017-01-14 19:01:38.412098Z] Finished download-and-extract step (success) 11:01:38 INFO - [mozharness: 2017-01-14 19:01:38.412248Z] Running populate-webroot step. 11:01:38 INFO - Running pre-action listener: _resource_record_pre_action 11:01:38 INFO - Running main action method: populate_webroot 11:01:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:01:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:01:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:01:38 INFO - '--tppagecycles', 11:01:38 INFO - '7'], 11:01:38 INFO - 'tests': ['tsvgm']}}, 11:01:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:01:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:01:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:01:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:01:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:01:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:01:38 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:01:38 INFO - 'talos_options': ['--disable-e10s'], 11:01:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:01:38 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:01:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:01:38 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:01:38 INFO - 'talos_options': ['--disable-e10s'], 11:01:38 INFO - 'tests': ['damp', 'tps']}, 11:01:38 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:01:38 INFO - 'tests': ['damp', 'tps']}, 11:01:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:01:38 INFO - 'tests': ['dromaeo_dom']}, 11:01:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:01:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:01:38 INFO - 'tests': ['basic_compositor_video']}, 11:01:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:01:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:01:38 INFO - 'tests': ['a11yr', 11:01:38 INFO - 'ts_paint', 11:01:38 INFO - 'tpaint', 11:01:38 INFO - 'sessionrestore', 11:01:38 INFO - 'sessionrestore_no_auto_restore', 11:01:38 INFO - 'tabpaint']}, 11:01:38 INFO - 'other-e10s': {'tests': ['a11yr', 11:01:38 INFO - 'ts_paint', 11:01:38 INFO - 'tpaint', 11:01:38 INFO - 'sessionrestore', 11:01:38 INFO - 'sessionrestore_no_auto_restore', 11:01:38 INFO - 'tabpaint']}, 11:01:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:01:38 INFO - 'ts_paint', 11:01:38 INFO - 'tpaint', 11:01:38 INFO - 'sessionrestore', 11:01:38 INFO - 'sessionrestore_no_auto_restore', 11:01:38 INFO - 'tabpaint']}, 11:01:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:01:38 INFO - 'ts_paint', 11:01:38 INFO - 'tpaint', 11:01:38 INFO - 'sessionrestore', 11:01:38 INFO - 'sessionrestore_no_auto_restore', 11:01:38 INFO - 'tabpaint']}, 11:01:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:01:38 INFO - 'tests': ['a11yr', 11:01:38 INFO - 'ts_paint', 11:01:38 INFO - 'tpaint', 11:01:38 INFO - 'sessionrestore', 11:01:38 INFO - 'sessionrestore_no_auto_restore', 11:01:38 INFO - 'tabpaint']}, 11:01:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:01:38 INFO - 'tests': ['a11yr', 11:01:38 INFO - 'ts_paint', 11:01:38 INFO - 'tpaint', 11:01:38 INFO - 'sessionrestore', 11:01:38 INFO - 'sessionrestore_no_auto_restore', 11:01:38 INFO - 'tabpaint']}, 11:01:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:01:38 INFO - 'tests': ['tsvgx', 11:01:38 INFO - 'tsvgr_opacity', 11:01:38 INFO - 'tart', 11:01:38 INFO - 'tscrollx', 11:01:38 INFO - 'cart', 11:01:38 INFO - 'tsvg_static']}, 11:01:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:01:38 INFO - 'tsvgr_opacity', 11:01:38 INFO - 'tart', 11:01:38 INFO - 'tscrollx', 11:01:38 INFO - 'cart', 11:01:38 INFO - 'tsvg_static']}, 11:01:38 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:01:38 INFO - 'talos_options': ['--disable-e10s'], 11:01:38 INFO - 'tests': ['tp5o']}, 11:01:38 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:01:38 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:01:38 INFO - 'talos_options': ['--disable-e10s', 11:01:38 INFO - '--xperf_path', 11:01:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:01:38 INFO - 'tests': ['tp5n']}, 11:01:38 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:01:38 INFO - 'talos_options': ['--xperf_path', 11:01:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:01:38 INFO - 'tests': ['tp5n']}}, 11:01:38 INFO - 'talos.zip': {'path': '', 11:01:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:01:38 INFO - Running post-action listener: _resource_record_post_action 11:01:38 INFO - [mozharness: 2017-01-14 19:01:38.430536Z] Finished populate-webroot step (success) 11:01:38 INFO - [mozharness: 2017-01-14 19:01:38.430647Z] Running create-virtualenv step. 11:01:38 INFO - Running pre-action listener: _resource_record_pre_action 11:01:38 INFO - Running main action method: create_virtualenv 11:01:38 INFO - Creating virtualenv /builds/slave/test/build/venv 11:01:38 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 11:01:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:01:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:01:38 INFO - Using real prefix '/tools/python27' 11:01:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:01:39 INFO - Installing distribute.............................................................................................................................................................................................done. 11:01:42 INFO - Installing pip.................done. 11:01:42 INFO - Return code: 0 11:01:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:01:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:01:42 INFO - Reading from file tmpfile_stdout 11:01:42 INFO - Output received: 11:01:42 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) 11:01:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:01:42 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')]} 11:01:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:42 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')]} 11:01:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:42 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 0x10871eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108721768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff401d85760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084fcd30>, '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 0x108423db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1084f1be8>, '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.7EebYWXfGg/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.yQbYWeEOSN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:01:42 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 11:01:42 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 11:01:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7EebYWXfGg/Render', 11:01:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:01:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:01:42 INFO - 'HOME': '/Users/cltbld', 11:01:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:01:42 INFO - 'LOGNAME': 'cltbld', 11:01:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:42 INFO - 'MOZ_NO_REMOTE': '1', 11:01:42 INFO - 'NO_EM_RESTART': '1', 11:01:42 INFO - 'PAGER': '/bin/cat', 11:01:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:01:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:01:42 INFO - 'PWD': '/builds/slave/test', 11:01:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:01:42 INFO - 'SHELL': '/bin/bash', 11:01:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yQbYWeEOSN/Listeners', 11:01:42 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 11:01:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:01:42 INFO - 'USER': 'cltbld', 11:01:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:01:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:01:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:42 INFO - 'XPC_FLAGS': '0x0', 11:01:42 INFO - 'XPC_SERVICE_NAME': '0', 11:01:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:01:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:42 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 11:01:42 INFO - Cleaning up... 11:01:42 INFO - Return code: 0 11:01:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:01:42 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')]} 11:01:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:42 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')]} 11:01:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:42 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 0x10871eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108721768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff401d85760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084fcd30>, '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 0x108423db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1084f1be8>, '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.7EebYWXfGg/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.yQbYWeEOSN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:01:42 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 11:01:42 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 11:01:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7EebYWXfGg/Render', 11:01:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:01:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:01:42 INFO - 'HOME': '/Users/cltbld', 11:01:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:01:42 INFO - 'LOGNAME': 'cltbld', 11:01:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:42 INFO - 'MOZ_NO_REMOTE': '1', 11:01:42 INFO - 'NO_EM_RESTART': '1', 11:01:42 INFO - 'PAGER': '/bin/cat', 11:01:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:01:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:01:42 INFO - 'PWD': '/builds/slave/test', 11:01:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:01:42 INFO - 'SHELL': '/bin/bash', 11:01:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yQbYWeEOSN/Listeners', 11:01:42 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 11:01:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:01:42 INFO - 'USER': 'cltbld', 11:01:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:01:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:01:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:42 INFO - 'XPC_FLAGS': '0x0', 11:01:42 INFO - 'XPC_SERVICE_NAME': '0', 11:01:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:01:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:42 INFO - Downloading/unpacking psutil>=3.1.1 11:01:42 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 11:01:42 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 11:01:42 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 11:01:42 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 11:01:42 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 11:01:42 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 11:01:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:01:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:01:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:01:46 INFO - Installing collected packages: psutil 11:01:46 INFO - Running setup.py install for psutil 11:01:46 INFO - building 'psutil._psutil_osx' extension 11:01:46 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 11:01:46 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 11:01:47 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 11:01:47 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 11:01:47 INFO - building 'psutil._psutil_posix' extension 11:01:47 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 11:01:47 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:01:47 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:01:47 INFO - ^ 11:01:47 INFO - 1 warning generated. 11:01:47 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 11:01:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:01:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:01:47 INFO - Successfully installed psutil 11:01:47 INFO - Cleaning up... 11:01:47 INFO - Return code: 0 11:01:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:01:47 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')]} 11:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:47 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')]} 11:01:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:47 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 0x10871eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108721768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff401d85760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084fcd30>, '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 0x108423db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1084f1be8>, '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.7EebYWXfGg/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.yQbYWeEOSN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:01:47 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 11:01:47 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 11:01:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7EebYWXfGg/Render', 11:01:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:01:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:01:47 INFO - 'HOME': '/Users/cltbld', 11:01:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:01:47 INFO - 'LOGNAME': 'cltbld', 11:01:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:47 INFO - 'MOZ_NO_REMOTE': '1', 11:01:47 INFO - 'NO_EM_RESTART': '1', 11:01:47 INFO - 'PAGER': '/bin/cat', 11:01:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:01:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:01:47 INFO - 'PWD': '/builds/slave/test', 11:01:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:01:47 INFO - 'SHELL': '/bin/bash', 11:01:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yQbYWeEOSN/Listeners', 11:01:47 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 11:01:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:01:47 INFO - 'USER': 'cltbld', 11:01:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:01:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:01:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:47 INFO - 'XPC_FLAGS': '0x0', 11:01:47 INFO - 'XPC_SERVICE_NAME': '0', 11:01:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:01:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:01:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:01:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:01:50 INFO - Installing collected packages: mozsystemmonitor 11:01:50 INFO - Running setup.py install for mozsystemmonitor 11:01:50 INFO - Successfully installed mozsystemmonitor 11:01:50 INFO - Cleaning up... 11:01:50 INFO - Return code: 0 11:01:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:01:50 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')]} 11:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:50 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')]} 11:01:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:50 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 0x10871eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108721768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff401d85760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084fcd30>, '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 0x108423db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1084f1be8>, '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.7EebYWXfGg/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.yQbYWeEOSN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:01:50 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 11:01:50 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 11:01:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7EebYWXfGg/Render', 11:01:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:01:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:01:50 INFO - 'HOME': '/Users/cltbld', 11:01:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:01:50 INFO - 'LOGNAME': 'cltbld', 11:01:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:50 INFO - 'MOZ_NO_REMOTE': '1', 11:01:50 INFO - 'NO_EM_RESTART': '1', 11:01:50 INFO - 'PAGER': '/bin/cat', 11:01:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:01:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:01:50 INFO - 'PWD': '/builds/slave/test', 11:01:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:01:50 INFO - 'SHELL': '/bin/bash', 11:01:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yQbYWeEOSN/Listeners', 11:01:50 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 11:01:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:01:50 INFO - 'USER': 'cltbld', 11:01:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:01:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:01:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:50 INFO - 'XPC_FLAGS': '0x0', 11:01:50 INFO - 'XPC_SERVICE_NAME': '0', 11:01:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:01:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:51 INFO - Downloading/unpacking jsonschema==2.5.1 11:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:01:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:01:53 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 11:01:53 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 11:01:53 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 11:01:53 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 11:01:53 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 11:01:53 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 11:01:54 INFO - Downloading functools32-3.2.3-2.tar.gz 11:01:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:01:54 INFO - warning: no files found matching '*.txt' 11:01:54 INFO - no previously-included directories found matching 'build' 11:01:54 INFO - no previously-included directories found matching 'dist' 11:01:54 INFO - no previously-included directories found matching '.git*' 11:01:54 INFO - Installing collected packages: jsonschema, functools32 11:01:54 INFO - Running setup.py install for functools32 11:01:54 INFO - warning: no files found matching '*.txt' 11:01:54 INFO - no previously-included directories found matching 'build' 11:01:54 INFO - no previously-included directories found matching 'dist' 11:01:54 INFO - no previously-included directories found matching '.git*' 11:01:54 INFO - Successfully installed jsonschema functools32 11:01:54 INFO - Cleaning up... 11:01:54 INFO - Return code: 0 11:01:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:01:54 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')]} 11:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:54 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')]} 11:01:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:54 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 0x10871eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108721768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff401d85760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084fcd30>, '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 0x108423db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1084f1be8>, '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.7EebYWXfGg/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.yQbYWeEOSN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:01:54 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 11:01:54 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 11:01:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7EebYWXfGg/Render', 11:01:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:01:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:01:54 INFO - 'HOME': '/Users/cltbld', 11:01:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:01:54 INFO - 'LOGNAME': 'cltbld', 11:01:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:54 INFO - 'MOZ_NO_REMOTE': '1', 11:01:54 INFO - 'NO_EM_RESTART': '1', 11:01:54 INFO - 'PAGER': '/bin/cat', 11:01:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:01:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:01:54 INFO - 'PWD': '/builds/slave/test', 11:01:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:01:54 INFO - 'SHELL': '/bin/bash', 11:01:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yQbYWeEOSN/Listeners', 11:01:54 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 11:01:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:01:54 INFO - 'USER': 'cltbld', 11:01:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:01:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:01:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:54 INFO - 'XPC_FLAGS': '0x0', 11:01:54 INFO - 'XPC_SERVICE_NAME': '0', 11:01:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:01:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:01:54 INFO - Cleaning up... 11:01:54 INFO - Return code: 0 11:01:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:01:54 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')]} 11:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:54 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')]} 11:01:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:54 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 0x10871eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108721768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff401d85760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084fcd30>, '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 0x108423db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1084f1be8>, '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.7EebYWXfGg/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.yQbYWeEOSN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:01:54 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 11:01:54 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 11:01:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7EebYWXfGg/Render', 11:01:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:01:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:01:54 INFO - 'HOME': '/Users/cltbld', 11:01:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:01:54 INFO - 'LOGNAME': 'cltbld', 11:01:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:54 INFO - 'MOZ_NO_REMOTE': '1', 11:01:54 INFO - 'NO_EM_RESTART': '1', 11:01:54 INFO - 'PAGER': '/bin/cat', 11:01:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:01:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:01:54 INFO - 'PWD': '/builds/slave/test', 11:01:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:01:54 INFO - 'SHELL': '/bin/bash', 11:01:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yQbYWeEOSN/Listeners', 11:01:54 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 11:01:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:01:54 INFO - 'USER': 'cltbld', 11:01:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:01:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:01:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:54 INFO - 'XPC_FLAGS': '0x0', 11:01:54 INFO - 'XPC_SERVICE_NAME': '0', 11:01:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:01:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:54 INFO - Downloading/unpacking blobuploader==1.2.4 11:01:54 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 11:01:54 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 11:01:54 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 11:01:54 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 11:01:54 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 11:01:54 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 11:01:57 INFO - Downloading blobuploader-1.2.4.tar.gz 11:01:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:01:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:01:57 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 11:01:57 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 11:01:57 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 11:01:57 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 11:01:57 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 11:01:57 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 11:01:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:01:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:01:58 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 11:01:58 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 11:01:58 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 11:01:58 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 11:01:58 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 11:01:58 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 11:01:58 INFO - Downloading docopt-0.6.1.tar.gz 11:01:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:01:58 INFO - Installing collected packages: blobuploader, requests, docopt 11:01:58 INFO - Running setup.py install for blobuploader 11:01:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:01:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:01:59 INFO - Running setup.py install for requests 11:01:59 INFO - Running setup.py install for docopt 11:01:59 INFO - Successfully installed blobuploader requests docopt 11:01:59 INFO - Cleaning up... 11:01:59 INFO - Return code: 0 11:01:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:01: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')]} 11:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01: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')]} 11:01:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:59 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 0x10871eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108721768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff401d85760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084fcd30>, '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 0x108423db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1084f1be8>, '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.7EebYWXfGg/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.yQbYWeEOSN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:01:59 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 11:01:59 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 11:01:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7EebYWXfGg/Render', 11:01:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:01:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:01:59 INFO - 'HOME': '/Users/cltbld', 11:01:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:01:59 INFO - 'LOGNAME': 'cltbld', 11:01:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:59 INFO - 'MOZ_NO_REMOTE': '1', 11:01:59 INFO - 'NO_EM_RESTART': '1', 11:01:59 INFO - 'PAGER': '/bin/cat', 11:01:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:01:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:01:59 INFO - 'PWD': '/builds/slave/test', 11:01:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:01:59 INFO - 'SHELL': '/bin/bash', 11:01:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yQbYWeEOSN/Listeners', 11:01:59 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 11:01:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:01:59 INFO - 'USER': 'cltbld', 11:01:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:01:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:01:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:59 INFO - 'XPC_FLAGS': '0x0', 11:01:59 INFO - 'XPC_SERVICE_NAME': '0', 11:01:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:01:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:01:59 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-7gxvdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:02:00 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-kefmL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:02:00 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-Q_d8M5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:02:00 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-OCiiml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:02:00 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-GDT9mE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:02:00 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-1dR_m3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:02:00 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-oVOd24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:02:00 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-_tkXnR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:02:00 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-bZxPHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:02:00 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-3Y2iIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:02:01 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-vytJbk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:02:01 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-pQNK_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:02:01 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-1vO9LL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:02:01 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-VbO_sM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:02:01 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-L8p4TE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:02:01 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-BNbBdo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:02:01 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-ojwdqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:02:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:02:01 INFO - Running setup.py install for manifestparser 11:02:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:02:01 INFO - Running setup.py install for mozcrash 11:02:02 INFO - Running setup.py install for mozdebug 11:02:02 INFO - Running setup.py install for mozdevice 11:02:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:02:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:02:02 INFO - Running setup.py install for mozfile 11:02:02 INFO - Running setup.py install for mozhttpd 11:02:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:02:02 INFO - Running setup.py install for mozinfo 11:02:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:02:02 INFO - Running setup.py install for mozInstall 11:02:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:02:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:02:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:02:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:02:02 INFO - Running setup.py install for mozleak 11:02:03 INFO - Running setup.py install for mozlog 11:02:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:02:03 INFO - Running setup.py install for moznetwork 11:02:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:02:03 INFO - Running setup.py install for mozprocess 11:02:03 INFO - Running setup.py install for mozprofile 11:02:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:02:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:02:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:02:03 INFO - Running setup.py install for mozrunner 11:02:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:02:03 INFO - Running setup.py install for mozscreenshot 11:02:04 INFO - Running setup.py install for moztest 11:02:04 INFO - Running setup.py install for mozversion 11:02:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:02:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:02:04 INFO - Cleaning up... 11:02:04 INFO - Return code: 0 11:02:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:02:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:02:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:04 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 0x10871eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108721768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff401d85760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084fcd30>, '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 0x108423db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1084f1be8>, '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.7EebYWXfGg/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.yQbYWeEOSN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:02:04 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 11:02:04 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 11:02:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7EebYWXfGg/Render', 11:02:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:02:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:02:04 INFO - 'HOME': '/Users/cltbld', 11:02:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:02:04 INFO - 'LOGNAME': 'cltbld', 11:02:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:04 INFO - 'MOZ_NO_REMOTE': '1', 11:02:04 INFO - 'NO_EM_RESTART': '1', 11:02:04 INFO - 'PAGER': '/bin/cat', 11:02:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:02:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:02:04 INFO - 'PWD': '/builds/slave/test', 11:02:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:02:04 INFO - 'SHELL': '/bin/bash', 11:02:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yQbYWeEOSN/Listeners', 11:02:04 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 11:02:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:02:04 INFO - 'USER': 'cltbld', 11:02:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:02:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:02:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:04 INFO - 'XPC_FLAGS': '0x0', 11:02:04 INFO - 'XPC_SERVICE_NAME': '0', 11:02:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:02:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:02:04 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-naLsUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:02:04 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)) 11:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:02:04 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-libMFd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:02:04 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)) 11:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:02:04 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-BnmSAb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:02:04 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)) 11:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:02:04 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-stfTFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:02:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:02:05 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-kEFSnR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:02:05 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)) 11:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:02:05 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-cw1lUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:02:05 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)) 11:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:02:05 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-8YGoCx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:02:05 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)) 11:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:02:05 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-mma6H8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:02:05 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)) 11:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:02:05 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-nRhNHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:02:05 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)) 11:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:02:05 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-R3KHFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:02:05 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)) 11:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:02:05 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-kE4oP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:02:05 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)) 11:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:02:05 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-ecRBsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:02:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:02:05 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-xT7W57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:02:05 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)) 11:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:02:05 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-OFTTfr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:02:06 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)) 11:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:02:06 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-aMe0Dt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:02:06 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)) 11:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:02:06 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-HTN2tv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:02:06 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)) 11:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:02:06 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-sgulL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:02:06 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)) 11:02:06 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)) 11:02:06 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)) 11:02:06 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)) 11:02:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:02:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:02:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:02:06 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 11:02:06 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 11:02:06 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 11:02:06 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 11:02:06 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 11:02:06 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 11:02:09 INFO - Downloading blessings-1.6.tar.gz 11:02:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:02:09 INFO - Installing collected packages: blessings 11:02:09 INFO - Running setup.py install for blessings 11:02:09 INFO - Successfully installed blessings 11:02:09 INFO - Cleaning up... 11:02:09 INFO - Return code: 0 11:02:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:02:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:02:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:02:10 INFO - Reading from file tmpfile_stdout 11:02:10 INFO - Current package versions: 11:02:10 INFO - blessings == 1.6 11:02:10 INFO - blobuploader == 1.2.4 11:02:10 INFO - docopt == 0.6.1 11:02:10 INFO - functools32 == 3.2.3-2 11:02:10 INFO - jsonschema == 2.5.1 11:02:10 INFO - manifestparser == 1.1 11:02:10 INFO - mozInstall == 1.12 11:02:10 INFO - mozcrash == 1.0 11:02:10 INFO - mozdebug == 0.1 11:02:10 INFO - mozdevice == 0.49 11:02:10 INFO - mozfile == 1.2 11:02:10 INFO - mozhttpd == 0.7 11:02:10 INFO - mozinfo == 0.9 11:02:10 INFO - mozleak == 0.1 11:02:10 INFO - mozlog == 3.4 11:02:10 INFO - moznetwork == 0.27 11:02:10 INFO - mozprocess == 0.24 11:02:10 INFO - mozprofile == 0.28 11:02:10 INFO - mozrunner == 6.13 11:02:10 INFO - mozscreenshot == 0.1 11:02:10 INFO - mozsystemmonitor == 0.3 11:02:10 INFO - moztest == 0.8 11:02:10 INFO - mozversion == 1.4 11:02:10 INFO - psutil == 3.1.1 11:02:10 INFO - requests == 1.2.3 11:02:10 INFO - wsgiref == 0.1.2 11:02:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:02: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')]} 11:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02: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')]} 11:02:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:10 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 0x10871eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108721768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff401d85760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084fcd30>, '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 0x108423db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1084f1be8>, '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.7EebYWXfGg/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.yQbYWeEOSN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:02:10 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 11:02:10 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 11:02:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7EebYWXfGg/Render', 11:02:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:02:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:02:10 INFO - 'HOME': '/Users/cltbld', 11:02:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:02:10 INFO - 'LOGNAME': 'cltbld', 11:02:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:10 INFO - 'MOZ_NO_REMOTE': '1', 11:02:10 INFO - 'NO_EM_RESTART': '1', 11:02:10 INFO - 'PAGER': '/bin/cat', 11:02:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:02:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:02:10 INFO - 'PWD': '/builds/slave/test', 11:02:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:02:10 INFO - 'SHELL': '/bin/bash', 11:02:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yQbYWeEOSN/Listeners', 11:02:10 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 11:02:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:02:10 INFO - 'USER': 'cltbld', 11:02:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:02:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:02:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:10 INFO - 'XPC_FLAGS': '0x0', 11:02:10 INFO - 'XPC_SERVICE_NAME': '0', 11:02:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:02:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:10 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)) 11:02:10 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)) 11:02:10 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)) 11:02:10 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)) 11:02:10 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)) 11:02:10 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)) 11:02:10 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)) 11:02:10 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)) 11:02:10 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)) 11:02:10 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)) 11:02:10 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)) 11:02:10 INFO - Cleaning up... 11:02:10 INFO - Return code: 0 11:02:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:02: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')]} 11:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02: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')]} 11:02:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10871eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108721768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff401d85760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084fcd30>, '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 0x108423db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1084f1be8>, '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.7EebYWXfGg/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.yQbYWeEOSN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:02: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', 'jsonschema'] in /builds/slave/test/build 11:02: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 jsonschema 11:02:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7EebYWXfGg/Render', 11:02:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:02:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:02:10 INFO - 'HOME': '/Users/cltbld', 11:02:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:02:10 INFO - 'LOGNAME': 'cltbld', 11:02:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:10 INFO - 'MOZ_NO_REMOTE': '1', 11:02:10 INFO - 'NO_EM_RESTART': '1', 11:02:10 INFO - 'PAGER': '/bin/cat', 11:02:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:02:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:02:10 INFO - 'PWD': '/builds/slave/test', 11:02:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:02:10 INFO - 'SHELL': '/bin/bash', 11:02:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yQbYWeEOSN/Listeners', 11:02:10 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 11:02:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:02:10 INFO - 'USER': 'cltbld', 11:02:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:02:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:02:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:10 INFO - 'XPC_FLAGS': '0x0', 11:02:10 INFO - 'XPC_SERVICE_NAME': '0', 11:02:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:02:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:02:11 INFO - Cleaning up... 11:02:11 INFO - Return code: 0 11:02:11 INFO - Running post-action listener: _resource_record_post_action 11:02:11 INFO - Running post-action listener: _start_resource_monitoring 11:02:11 INFO - Starting resource monitoring. 11:02:11 INFO - [mozharness: 2017-01-14 19:02:11.095964Z] Finished create-virtualenv step (success) 11:02:11 INFO - [mozharness: 2017-01-14 19:02:11.096962Z] Running install step. 11:02:11 INFO - Running pre-action listener: _resource_record_pre_action 11:02:11 INFO - Running main action method: install 11:02:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:02:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:02:11 INFO - Reading from file tmpfile_stdout 11:02:11 INFO - Detecting whether we're running mozinstall >=1.0... 11:02:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:02:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:02:11 INFO - Reading from file tmpfile_stdout 11:02:11 INFO - Output received: 11:02:11 INFO - Usage: mozinstall [options] installer 11:02:11 INFO - Options: 11:02:11 INFO - -h, --help show this help message and exit 11:02:11 INFO - -d DEST, --destination=DEST 11:02:11 INFO - Directory to install application into. [default: 11:02:11 INFO - "/builds/slave/test"] 11:02:11 INFO - --app=APP Application being installed. [default: firefox] 11:02:11 INFO - mkdir: /builds/slave/test/build/application 11:02:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:02:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 11:02:33 INFO - Reading from file tmpfile_stdout 11:02:33 INFO - Output received: 11:02:33 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:02:33 INFO - Running post-action listener: _resource_record_post_action 11:02:33 INFO - [mozharness: 2017-01-14 19:02:33.615251Z] Finished install step (success) 11:02:33 INFO - [mozharness: 2017-01-14 19:02:33.615386Z] Running run-tests step. 11:02:33 INFO - Running pre-action listener: _resource_record_pre_action 11:02:33 INFO - Running main action method: run_tests 11:02:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:02:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:02:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:02:33 INFO - 2017-01-14 11:02:33.629 screenresolution[1626:7422] starting screenresolution argv=screenresolution get 11:02:33 INFO - 2017-01-14 11:02:33.632 screenresolution[1626:7422] Display 0: 1600x1200x32@60 11:02:33 INFO - 2017-01-14 11:02:33.638 screenresolution[1627:7424] starting screenresolution argv=screenresolution list 11:02:33 INFO - Available Modes on Display 0 11:02:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:02:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:02:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:02:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:02:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:02:33 INFO - Intel Iris: 11:02:33 INFO - Chipset Model: Intel Iris 11:02:33 INFO - Type: GPU 11:02:33 INFO - Bus: Built-In 11:02:33 INFO - VRAM (Dynamic, Max): 1536 MB 11:02:33 INFO - Vendor: Intel (0x8086) 11:02:33 INFO - Device ID: 0x0a2e 11:02:33 INFO - Revision ID: 0x0009 11:02:33 INFO - Displays: 11:02:33 INFO - Display: 11:02:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:02:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:02:33 INFO - Display Serial Number: 1600x1200 60 11:02:33 INFO - Main Display: Yes 11:02:33 INFO - Mirror: Off 11:02:33 INFO - Online: Yes 11:02:33 INFO - Rotation: Supported 11:02:33 INFO - Return code: 0 11:02:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:02:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:02:33 INFO - Python 2.7.3 11:02:33 INFO - Return code: 0 11:02:33 INFO - grabbing minidump binary from tooltool 11:02: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')]} 11:02:33 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 0x1084fcd30>, '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 0x108423db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1084f1be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:02:33 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 11:02:33 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 11:02:33 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 11:02:33 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:02:33 INFO - Return code: 0 11:02:33 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:02:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:02:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:02:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:02:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:02:33 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/IOPa4sRRToGbahjHImyaBw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0291', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:02:33 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/IOPa4sRRToGbahjHImyaBw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0291 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:02:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7EebYWXfGg/Render', 11:02:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:02:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:02:34 INFO - 'HOME': '/Users/cltbld', 11:02:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:02:34 INFO - 'LOGNAME': 'cltbld', 11:02:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:02:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:02:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:34 INFO - 'MOZ_NO_REMOTE': '1', 11:02:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:02:34 INFO - 'NO_EM_RESTART': '1', 11:02:34 INFO - 'PAGER': '/bin/cat', 11:02:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:02:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:02:34 INFO - 'PWD': '/builds/slave/test', 11:02:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:02:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:02:34 INFO - 'SHELL': '/bin/bash', 11:02:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yQbYWeEOSN/Listeners', 11:02:34 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 11:02:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:02:34 INFO - 'USER': 'cltbld', 11:02:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:02:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:02:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:34 INFO - 'XPC_FLAGS': '0x0', 11:02:34 INFO - 'XPC_SERVICE_NAME': '0', 11:02:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:02:34 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/IOPa4sRRToGbahjHImyaBw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0291', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:02:34 INFO - mozversion application_buildid: 20170114093924 11:02:34 INFO - mozversion application_changeset: 5ce3882eec21be3a70e4afc050959ca2f76bfa76 11:02:34 INFO - mozversion application_display_name: Nightly 11:02:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:02:34 INFO - mozversion application_name: Firefox 11:02:34 INFO - mozversion application_remotingname: firefox 11:02:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:02:34 INFO - mozversion application_vendor: Mozilla 11:02:34 INFO - mozversion application_version: 53.0a1 11:02:34 INFO - mozversion platform_buildid: 20170114093924 11:02:34 INFO - mozversion platform_changeset: 5ce3882eec21be3a70e4afc050959ca2f76bfa76 11:02:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:02:34 INFO - mozversion platform_version: 53.0a1 11:02:34 INFO - using testdate: 1484420554 11:02:34 INFO - actual date: 1484420554 11:02:34 INFO - starting webserver on 'localhost:49242' 11:02:34 INFO - SUITE-START | Running 2 tests 11:02:34 INFO - TEST-START | dromaeo_css 11:02:34 INFO - operating with platform_type : mac_ 11:02:34 INFO - Initialising browser for dromaeo_css test... 11:02:34 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/tmp6wSi8M/profile http://localhost:49242/getInfo.html) 11:02:36 INFO - PROCESS | 1637 | 2017-01-14 11:02:36.976 plugin-container[1639:7590] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d3f, name = 'com.apple.tsm.portname' 11:02:36 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:02:36 INFO - PROCESS | 1637 | 2017-01-14 11:02:36.980 plugin-container[1639:7590] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x930b, name = 'com.apple.CFPasteboardClient' 11:02:36 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:02:36 INFO - PROCESS | 1637 | 2017-01-14 11:02:36.980 plugin-container[1639:7590] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:02:37 INFO - PROCESS | 1637 | __metrics Screen width/height:1600/1200 11:02:37 INFO - PROCESS | 1637 | colorDepth:24 11:02:37 INFO - PROCESS | 1637 | Browser inner width/height: 1024/663 11:02:37 INFO - PROCESS | 1637 | __metrics 11:02:37 ERROR - PROCESS | 1637 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3249: TypeError: this.tabs is undefined 11:02:37 INFO - TEST-INFO | 1637: exit 0 11:02:37 INFO - Browser initialized. 11:02:37 INFO - Running cycle 1/1 for dromaeo_css test... 11:02:37 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/tmp6wSi8M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:02:40 INFO - PROCESS | 1640 | 2017-01-14 11:02:40.214 plugin-container[1641:7718] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4343, name = 'com.apple.tsm.portname' 11:02:40 INFO - PROCESS | 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:02:40 INFO - PROCESS | 1640 | 2017-01-14 11:02:40.215 plugin-container[1641:7718] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4717, name = 'com.apple.CFPasteboardClient' 11:02:40 INFO - PROCESS | 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:02:40 INFO - PROCESS | 1640 | 2017-01-14 11:02:40.215 plugin-container[1641:7718] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:02:49 INFO - PROCESS | 1640 | RSS: Main: 244150272 11:02:49 INFO - PROCESS | 1640 | 11:05:52 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 11:05:54 INFO - PROCESS | 1640 | RSS: Main: 259149824 11:05:54 INFO - PROCESS | 1640 | 11:07:38 INFO - PROCESS | 1640 | ************************* 11:07:38 INFO - PROCESS | 1640 | A coding exception was thrown and uncaught in a Task. 11:07:38 INFO - PROCESS | 1640 | 11:07:38 ERROR - PROCESS | 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:07:38 INFO - PROCESS | 1640 | Full stack: 11:07:38 INFO - PROCESS | 1640 | ************************* 11:08:56 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 11:08:57 INFO - PROCESS | 1640 | RSS: Main: 267939840 11:08:57 INFO - PROCESS | 1640 | 11:11:58 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 11:11:59 INFO - PROCESS | 1640 | RSS: Main: 278601728 11:11:59 INFO - PROCESS | 1640 | 11:15:01 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 11:15:02 INFO - PROCESS | 1640 | RSS: Main: 274796544 11:15:02 INFO - PROCESS | 1640 | 11:18:04 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 11:18:05 INFO - PROCESS | 1640 | RSS: Main: 279670784 11:18:05 INFO - PROCESS | 1640 | 11:21:08 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 11:21:08 INFO - PROCESS | 1640 | RSS: Main: 281927680 11:21:08 INFO - PROCESS | 1640 | 11:21:08 INFO - PROCESS | 1640 | __start_tp_report 11:21:08 INFO - PROCESS | 1640 | _x_x_mozilla_page_load 11:21:08 INFO - PROCESS | 1640 | _x_x_mozilla_page_load_details 11:21:08 INFO - PROCESS | 1640 | |i|pagename|runs| 11:21:08 INFO - PROCESS | 1640 | |0;dojo.html;2684.0337478507736;3163.5096560033194;3383.5432216650743;3388.542546756187;3424.743144264179;5467.753951072212;5626.831195064145;5733.455321744433;5737;5750.338711048231;5647.915281270784;5723.828285151452;5807.477327040566;5860.648361098337;5882.735276912538;5212.765425555859;5278.762455689484;5281.970015846901;5290.7354632268425;5325.121354976424;5233.764480598382;5350.250964864922;5353.678779273237;5372.623916325859;5386.976474469858;5319.9734001330135;5334.306540149775;5337.4662533746705;5344.118220493614;5346.572274218053;5136.9743151284;5163.302954101224;5175.430702622709;5203.19350500673;5280.2079688046715;5184.559312458446;5185.429602743695;5206.323177986837;5273.841784746463;5307.097793375136;4415.735055896656;5650.208970744099;5746.597738158331;5824.126381042835;5827.300723913115;6185.134081228632;6197.5351848611535;6204.069389591597;6275.309715931244;6356.110144579762;6240.906386404207;6303.401176888188;6308.211473565804;6333.8416539586415;6340.524460665469;5993.280806303272;6020.548458865603;6037.72830222641;6041.063635136561;6078.057901025348;6208.689565521706;6276.623402595859;6333.778317758856;6341.8097457076365;6371.299157092716;4896.4858689837765;6104.877902441926;6157.4458298753325;6265.342139075331;6277.780277690259;6272.278687950853;6292.182016337847;6300.558960872787;6326.652034138075;6333.746650134035;6145.40219542922;6175.907361389583;6194.566380353423;6224.346443623445;6302.684865756693;6288.245410550763;6292.968535157386;6294.433500984934;6330.208723909512;6334.904976425358;4993.975030124899;5027.622928280393;5029.06962211992;5045.041442125985;5058.949410505921;4383.671224658164;4464.531224221475;4481.686281960297;4500.617447516997;4501.864944051684;5915.881682366328;5979;6018.247719035121;6025.216721826135;6095.05526643371;6290.811275661737;6292.150559674477;6297.590656607306;6311.274203466568;6313.43179113882;5693.914591281134;5768.884622307531;5957.970210149008;5975.79084732041;6034.125051867454;5424.105022671294;5473;5479.972600136974;5481.616286859881;5501.5323697486165;5650.943490565041;6255.093011513305;6423.582467139621;6430.2605200400685;6436.259830119502;5215.800365915785;5861.32594751609;6274.592151510137;6278.591891527036;6299.401556852092;6201.503879689704;6259.12372267892;6361.936380636134;6377.553571249968;6465.224173099258;5400.972995134999;6172.722227499684;6184.5980011299125;6234.220722409699;6238.563300569098;6223.502119830312;6230.06549017651;6238.220222472191;6255.218097737783;6266.624002559679;6034.336223015377;6152.907706384318;6229.159063526366;6233.594816336924;6237.4698150657705;5966.76132954677;6101.792513241593;6112.625067133501;6143.784967526115;6186.1648677427975;5951.047832346804;5954.821355359346;6003.90994135097;6106.491003209229;6118.314626315779;6112.077967281658;6113.32428171423;6118.296395914527;6132.845047373448;6132.846678833065;5989.4310040547825;6041.456268935641;6044.395560444096;6056.485198758155;6061.605995610271 11:21:08 INFO - PROCESS | 1640 | |1;ext.html;442.6259810460162;456.9680122391432;474.2554189921823;486.20748180465836;496.7119070938856;38200.42699359509;40757.59242407579;40884.59115408845;42663.72008839732;42854.14291714164;41150.58849411512;41449;41717.16565668685;41767.95580110499;41778;9197.264218862474;9424.198943089845;9442.858357124614;10824;11220.438978051106;11010.449477526132;11105.666829995112;11111.83332250017;11115.944420277887;11126.777464450706;10581.78836423271;11110.722231944226;11118.888811111867;11145.16411269154;11148.275362101438;11066.612668556601;11079.113670906308;11089.72275693102;11093.16801239902;11116.555337786478;10977.725556861142;11047.116230701524;11056.668299951014;11059.72350691231;11065.889341106647;36507.63492365069;36683.26633467316;36847.815760921025;36856;36896.81551592251;3970.245653325888;3997.960020399788;4021.8391264349393;4022.1352409231863;4120.526139493966;27798;28015;28195;28207.012754553696;28249.858750706117;3030.0606811888383;3155.9053228403186;3241.8541165647603;3283.40898638245;3292.489664102068;432603;447886.7605661983;453455;454618;456759;45027.77486112549;55153.72423137858;55337;55353.72323138439;55383.723081384334;54072.29638518058;54164.187537186976;54168.72915635397;54221.457785422426;54319;14882;15252.771208431883;15276.694466110615;15318.463853765288;15322.846771532364;9165.954170229106;10609.098226650667;10912;11619.6514104577;11872.168948173718;17232.913835430994;17267.65464690699;17269.87745796519;17282.65434691299;17283.049432281096;7140.500164988401;7719.189485104095;8279.254867061993;8303.916960830435;8375.120612335739;860.2300940658076;881.6076845803684;884.8894637230235;904.2585080234277;925.3291363761219;24034.7596524036;29661.110166695034;29879.551806722917;29937.700622993925;31020.844895775826;1061.7717190804015;1067.8291473364225;1072.7371793910386;1103.3214573037685;1108.3737688206138;14704.970652054468;15033;15627.531174064796;15703.450379236672;15746.448874289345;240800;241878;242230.57769422434;242374;242786;58491.70754146202;59015.40984590185;59161.40838591559;59203.815923682145;59227.40772592219;1305.236436684531;1394.909330893509;1434.9210793406462;1438.8345340286;1450.1154295879505;25267.62098568486;27057.72942270552;27756.44487110206;29844.701552984192;29883.402331952806;45160.77419612881;45321.54678453173;45375.773121135506;45395.319070213314;45492.77253613843;522513;523355;523372;525227;526232;23005.194818181284;23683.763162368847;25620.61569076428;26069.826857791824;26470.735292646827;45192.87017824581;46009.849753756425;46446;46552.41371035362;47334.28998564956;30019.799208031432;33157.33685326328;37874;38130.61869381271;38480.8571555955;37192.628073718915;37472.063198420256;37861;38086.047848804;38251.133506247235;36114.4582831263;36381.454278185316;37144.628553714116;37255.44116838304;37331.81334093312;32173;33371.16572085717;33631.327373452885;33919.321613568085;33978;24941.625875612244;24988.50022999566;25251.74748252494;25258.36854078663;25278.74721252764 11:21:08 INFO - PROCESS | 1640 | |2;jquery.html;366.6736604422064;390.1280637774573;394.84206317473024;400.997995010025;423.62085933089884;16248.83751162488;19592.216311347547;20411.775293482366;20864.687029694567;20878.478038049037;20751.273705420313;20816.791832081675;21095.2616658417;21599.244026459077;21845;5506.669599824013;5787.450192231752;5789.565782566303;5796.362400135981;5810.9418905811035;5589.916151257735;5685.687287199203;5686.829395118153;5703.144528320744;5790.420957904197;4492.775361231942;4937.185364414885;5225.63420560559;5682.607761098516;5682.971585142089;5457.945420545783;5611.186377975211;5657.264555607765;5667.291588551431;5673.744681489343;4993.6005119590345;5001.249812528114;5005.849824505271;5012.749362531858;5025;21929.451763705874;25988.220353389428;26070.087546935956;26110.477790444274;26262.737372626412;2143.3569929021232;2386.4391867911027;2695.5417579011614;2759.951218536963;2770.667519897625;14734.263286835723;15318.846811531854;15679.92160039204;15715.192752833456;15758.527244182693;1588.849059339361;1818.5908170661628;1825.790034146077;1842.6406850664125;1843.0508288231572;125498.37250813779;126985;128413.35793320973;130868;130959;10870.293430926964;11592.47833847479;11629.709257268467;11653.708657283636;11808.409579520989;12580.245185288912;13095.607131786062;14228.502002429865;14278.857211427752;14287.214203218922;8292.33661307094;8557.358198135165;8627.309815214769;8663.826723465496;8772;8537.786555336166;8548.786280343042;8599.14008599135;8648.654053837901;8697.304215662733;7036.226015138331;7113.288671132948;7118.92881071193;7129.714811407485;7139.82150446243;1972.447714639903;2006.2476571285767;2006.6087113012823;2007.197121151551;2007.718919351292;894.9886628110324;911.9316051296047;1047.1727335404944;1052.2476429353048;1103.4648195625116;20201.292954746514;21300.467488312606;22429.775702243096;22658.546829063656;22886.08455661755;1057.7408534908996;1061.8991195836384;1090.7818436312768;1091.5579190427732;1092.2627226622158;9973.80052398948;10568;11226.7193320166;11813.527458901719;11845.170838041255;373063;486525.56737216085;720826.3958680173;732089;735831;134423;135072.3246383762;136477;137243;140727;997.2221667099674;1013.5945621751358;1035.3684252605904;1038.8234000219982;1050.9842352364722;16464.014952747668;19444.930528820485;19691.916944568187;19754.209831606575;19853.503662408555;53301.73349133385;54212.728936355066;54504.727476362365;55016.72491637516;55486;78402;80423.59788201022;80767.59616202116;89467.55266223887;91173.54413227891;8112.83774324522;8219.301359384519;8350.916490835258;8562.400631955952;8649;11857.11071669611;13107.606771796862;13404.530841420503;13502.392392342172;13626;11115.388653624128;11211.66365009051;11562.595309164139;11713.238639488405;11739.11956603241;9182.219511341611;10822.945885270523;11009;11612.88387116118;11729.648110556696;9843.208186351394;11496.022838058858;11810.822837657613;11842.585509507126;11880.940595296968;7462.96268518654;8054.509915665386;8444.873326900224;8469.74590762278;8548.74353769388;9330;11301.547938082385;11403.429828508708;11634.476448559666;11683 11:21:08 INFO - PROCESS | 1640 | |3;mootools.html;1232.1929136415647;1283.2172374851345;1456.1772598481857;1477.135875512825;1493.1936754152757;7613.7335193268245;7854.607269636524;8157.347412207024;8595.527246001475;8643.141724529225;8044.6782128714785;8166.79583010425;8320;8424.578771061453;8455.112213217615;1980.5840773437596;1980.9603807923834;2307.1348244408305;2329.974811083118;2383.177803657744;2096.4758810297426;2157.7410710714657;2330.6270996640455;2363.125643511903;2378.892949817254;2215.4793623498463;2283.303592404316;2287.176616418088;2296.59809533331;2315.5600435917204;2346.143657564985;2349.1895296122725;2349.788519033278;2371.383440305533;2374.964375534368;2332.148765700524;2337.403961989699;2399.472116134448;2400.663907053014;2406.987965060181;8513.404061715682;8556.48661080331;8563;8575.742727718178;8595.914040859636;5147.510986456281;5302.92045619316;5309.787608495694;5321.175217841241;5333.120035194188;3399.1162297802503;3594.9101272468138;3622.4385220290897;3631.7457777955287;3647.416413373874;1177.0223900861554;1212.563477148226;1246.7132559511363;1258.7293731847697;1265.7848165811833;11038.337699738042;11058.170637202242;11139.721506962309;11154.330740155616;11157.497912593954;4644.815572029111;4738.360321356642;4771.976140119277;4773.498782627844;4806.2310030394965;9443.386179898285;9511.476868772146;9527.90472095284;9534.23726101924;9555.23558115349;5266.97366513165;5270.8155214567305;5273.5253827154975;5273.815416460482;5277.920831187535;4594.540545945379;4769.976150119297;4821.734804585712;4916.385451818523;4936.531029552187;3332.8833490828188;3835.712321575893;3924.1955399143108;3984.5019372578427;4000.4199391088127;1198.3289357959395;1241.3669028795198;1269.4033804112053;1304.1914013311807;1309.9148555343872;879.7536689726886;887.6227603268585;889.2707979456783;901.5695279461711;915.6200176926501;5036.521530454675;5181.81863634771;5411.648242864201;5487.368952570506;5697.914531282034;998.6804222648683;1007.6271779441654;1014.7361685961555;1031.515187861704;1049.6483677967967;3604.9098772530374;3722.10669439338;3820.471811275512;3832.3293423651307;3833.271678381099;9933.751656208653;10220.233482488844;10268.127209187154;10268.127209187154;10274.22943279257;9889.851652225223;10133.138683211862;10150.593976240867;10213.94893025545;10227.539760710786;7843.882341764764;7916.168802275678;7980.720674776355;8011.919880801117;8031.277185053374;5100.668456550312;5441.428649991693;5465.808696695596;5524.226608274925;5540.390557038642;7734.381249500139;9058.320625952949;9299;9429.575669095044;9465.574049167666;8683.609237584451;9079.409838360485;9086;9477.810443791224;9545.474998875128;7102.573845569283;7258.129024517092;7278.526895751759;7279.745208917662;7304.890426643711;7826.256505631955;7855.293023627901;7871.448998570045;7878.881816772639;7899.68401263943;7058;7113.822154445973;7177.641117944187;7217.206107328295;7294.1247050354295;7004.0544526488275;7017.894731578928;7043.7534686285735;7073.752418665322;7115.573065615872;4909.288153217834;6268.561200716089;6335.429811317003;6350.809475715736;6356;4937.506249375034;4962.206047032601;4966.205407134841;4966.379202599675;5038.823641172541;4407.2067027934;4851.902961940671;4903.362562866804;4955.851324460272;5030.968651426522 11:21:08 INFO - PROCESS | 1640 | |4;prototype.html;357.79963220596466;363.9490471334013;371.45767179917317;374.36171327885955;377.2059814091336;4409.897525618595;4575.88560285993;4679.227927391977;5015.999999999995;5197.116490196666;4484.372187893689;4553.385292985446;5237.921431178535;5311.920321195175;5421.430749771276;3640.7087433005427;3718.888433347004;4213.410122582825;4218.219629368561;4225.239456897757;3398.9150271243293;4004.537209616094;4240.533541310453;4247.8300867965245;4251.936220956688;4081.4490043844;4156.625903668669;4160.771157586331;4164.937525937114;4177.582241775814;4135.97932010341;4161.875143745692;4174.519930208035;4175.102352994121;4193.6645068394455;3297.7526685498683;3524.4713293006;3678.1241566801123;3708.295423869456;3710.406334986389;5046;5159.922601160985;5165.509276618715;5209.921851172236;5275.815346462856;3901.6785012917267;4805.303231031481;4814.975925120387;4822.397200349957;4846.29728689338;5707.315122185364;5729.484346408802;5733.505924922631;5773.9422605773825;5789.565782566325;3304.487804390323;3875.2249550090096;4072.53165885921;4099.733517321364;4101.876943691694;5758.337791154029;5994.580379373446;5998.590331272191;6004.669743164124;6014.609050411709;3674.52231209941;3785.523645778149;4162.854300099482;4177.456930599003;4181.268278051329;3479.321532301177;3725.6646901778427;4075.3071977763852;4217.810198541073;4230.2174097792;4127.669786417079;4594.425696787902;4714.339992401066;4847.473045990501;4890.046440943982;4459.2163134745715;4846.909445374833;5160.509751573594;5238.842834714965;5676.552479117881;1224.9848998397586;1242.7510352096085;1256.5539233572133;1281.9615411537668;1394.6583087143513;853.5262929074423;880.2869675562814;882.9426087304305;883.2801266967401;890;4309.569043095728;4696.577308042292;4748.121597504472;5127.948720512747;5150.253213284052;4737.455192652889;4951.603871690256;5516.3380394352935;5564.1931919871395;5651.350094739158;4738.739369334719;5039.370078740158;5041.773120209526;5083.694978301313;5115.309433226466;2560.3215147985798;2657.720939301384;2923.5906973023793;2938.4416960777385;2944.4994350960387;5467.125259958467;5797.768089276466;5835.5915085944425;5867.442592953663;5882.352941176488;4887.2650209175945;5218.817341393033;5362.919556206582;5579.9163012554845;5766.769329226868;5123.513266239701;5140.511651393186;5562.249096371938;5818.970905145447;5883;4728.456227533878;4953.869835970568;5630.408807075362;5672.858178545569;5758.400999375391;5118.370388771581;5176.4305926348825;5457.61796674229;5565.860853478695;5579.944200558105;5287.709175995204;5530.861728456821;5566.749496272597;5652.943470565407;5866.005558110263;3239.9190020249684;3245.8539365728125;3378.9525247172473;3491.8079505627434;3754.099016236029;4881.414230292387;5175.257113729729;5349.956758432068;5558.749856256397;5627.88744225105;5018.723970181675;5586.748596313257;5649.237352957298;5789.8552536186935;5823.505002074871;4686.554777296152;5264.657797243167;5376.892462150813;5720.2839148254525;5757.596968212352;5367.577591938218;5514.6691198528215;5635.323761148688;5650.830475085754;5661.490465858093;5291.76187071575;5708.258981010831;5719.28508936383;5778.884422311614;5806.709664516673;4986.982875360355;5629.774809007594;5636.126400407943;5661.745221465127;5668.603197776281 11:21:08 INFO - PROCESS | 1640 | |5;yui.html;717.9353858152768;774.6126936531731;817.395127605572;825.3397282174261;826.5206180415362;11559.942200289008;15460.845391546081;15686.607834804136;16108.033517988928;16169.029858208502;14675.412983480675;14759.966802323841;14838.406463741465;14869;14869.256537173125;685.2325395556958;709.5033476566398;850.8893843800329;865.7965378136133;887.0331338840663;867.6789587852503;881.5195718333524;887;888.6578667213137;892.1836519584572;942.604106275366;947.010374159002;947.1381043250643;947.5167664491124;948.5446985446989;919.4207649180973;931.7018554062703;938.6151677812098;940.1538615246264;940.6736501532874;699.220369288245;701.5404909784099;703.4583370804503;704.9224585295614;705.693023534764;14541.054831435922;14619.63450913725;14695.338709758087;15564;16070.035797852166;12024;14622.634434139125;14860.52358528215;14885.33016014282;15288.388464461408;11685.357305348203;11804.586839460577;11884.286942783374;11981.700457488545;12273.079519036108;3715.888523344277;3754.699624030098;3791.563970143441;3900.0054985978677;3901.375779875235;112147;112215;114306.14234644118;115476;116950.41524792321;11135.665930022113;11150.330980141056;11256.437178141061;11295.774084518263;11652.242604230698;23701.762982369957;23908.163214287415;24279.39301517441;24305.513889722108;24305.75694243035;7823;7827.843443131105;7847.176046515148;7895.960520197362;7966.960165199137;4246.10831725335;4291.249031419489;4310.202612516632;4367.82068841411;4457.977710111493;3126.7024184962984;3526.84129214186;3603.261331427051;3629.854805807791;3634.055145662147;650.681166228554;651.635084352764;659.1840370568251;665.6139439125295;675.3314218923231;605.5004621187538;664.5613894829389;690.944724422045;725.5320318394606;729.6424751871544;9794.853077203848;10312.175025997902;10353.4305613192;10385.169186465064;10519.304280395578;700.6111608057475;714.5248409807524;715.853250083742;716.3544414472144;721.0770214125927;4649.488556258809;5054.949450505522;5070.923936140961;5087.821926232638;5099.23511473282;98673.50663246638;99201;100655;103086;106436.46781766042;61435.6928215365;77827.61086194533;89677.75805604912;93733;94114.52942735242;78597.214027859;79560.60219698865;79633;80709.5964520162;82493;8250.669973201006;8342.87485687703;9780.26648001417;9812.65655702047;9815.852762208715;43364.78317608392;45963.62109136731;48448;49584.75207623939;53532.73233633963;65053.67473162604;67330;68363;68532.657336713;70279.29720702728;11926.224795388272;11937.880621194025;11946.104042196695;12009;12020;10310.432926188832;10646.361218326925;12809.231446113263;12870.099093063396;13052.477900883858;11914.642560723192;12042.337671428155;12263.93868030654;12460.376981151088;12468.314242716737;11897.881021189678;12071.336076515876;12151.81772273399;12476.937615311865;12520.248785072925;11791;11924.821127683264;12216.961558267647;12443.128980971245;12527.87472125267;10010.249231307535;10123.470252640413;10140.995948164298;10222.897771022492;10515.684529464128;8920.86618700733;9690.273229507675;9731.124198821857;9747;9749.805003900025 11:21:08 INFO - PROCESS | 1640 | __end_tp_report 11:21:08 INFO - PROCESS | 1640 | __start_cc_report 11:21:08 INFO - PROCESS | 1640 | _x_x_mozilla_cycle_collect,384 11:21:08 INFO - PROCESS | 1640 | __end_cc_report 11:21:08 INFO - PROCESS | 1640 | __startTimestamp1484421668659__endTimestamp 11:21:08 INFO - PROCESS | 1640 | 11:21:08 INFO - PROCESS | 1640 | ------- Summary: start ------- 11:21:08 INFO - PROCESS | 1640 | Number of tests: 6 11:21:08 INFO - PROCESS | 1640 | 11:21:08 INFO - PROCESS | 1640 | [#0] dojo.html Cycles:165 Average:5777.45 Median:6037.73 stddev:671.06 (11.1%) stddev-sans-first:627.71 11:21:08 INFO - PROCESS | 1640 | Values: 2684.0 3163.5 3383.5 3388.5 3424.7 5467.8 5626.8 5733.5 5737.0 5750.3 5647.9 5723.8 5807.5 5860.6 5882.7 5212.8 5278.8 5282.0 5290.7 5325.1 5233.8 5350.3 5353.7 5372.6 5387.0 5320.0 5334.3 5337.5 5344.1 5346.6 5137.0 5163.3 5175.4 5203.2 5280.2 5184.6 5185.4 5206.3 5273.8 5307.1 4415.7 5650.2 5746.6 5824.1 5827.3 6185.1 6197.5 6204.1 6275.3 6356.1 6240.9 6303.4 6308.2 6333.8 6340.5 5993.3 6020.5 6037.7 6041.1 6078.1 6208.7 6276.6 6333.8 6341.8 6371.3 4896.5 6104.9 6157.4 6265.3 6277.8 6272.3 6292.2 6300.6 6326.7 6333.7 6145.4 6175.9 6194.6 6224.3 6302.7 6288.2 6293.0 6294.4 6330.2 6334.9 4994.0 5027.6 5029.1 5045.0 5058.9 4383.7 4464.5 4481.7 4500.6 4501.9 5915.9 5979.0 6018.2 6025.2 6095.1 6290.8 6292.2 6297.6 6311.3 6313.4 5693.9 5768.9 5958.0 5975.8 6034.1 5424.1 5473.0 5480.0 5481.6 5501.5 5650.9 6255.1 6423.6 6430.3 6436.3 5215.8 5861.3 6274.6 6278.6 6299.4 6201.5 6259.1 6361.9 6377.6 6465.2 5401.0 6172.7 6184.6 6234.2 6238.6 6223.5 6230.1 6238.2 6255.2 6266.6 6034.3 6152.9 6229.2 6233.6 6237.5 5966.8 6101.8 6112.6 6143.8 6186.2 5951.0 5954.8 6003.9 6106.5 6118.3 6112.1 6113.3 6118.3 6132.8 6132.8 5989.4 6041.5 6044.4 6056.5 6061.6 11:21:08 INFO - PROCESS | 1640 | 11:21:08 INFO - PROCESS | 1640 | [#1] ext.html Cycles:180 Average:55648.98 Median:33775.32 stddev:112389.84 (332.8%) stddev-sans-first:112628.69 11:21:08 INFO - PROCESS | 1640 | Values: 442.6 457.0 474.3 486.2 496.7 38200.4 40757.6 40884.6 42663.7 42854.1 41150.6 41449.0 41717.2 41768.0 41778.0 9197.3 9424.2 9442.9 10824.0 11220.4 11010.4 11105.7 11111.8 11115.9 11126.8 10581.8 11110.7 11118.9 11145.2 11148.3 11066.6 11079.1 11089.7 11093.2 11116.6 10977.7 11047.1 11056.7 11059.7 11065.9 36507.6 36683.3 36847.8 36856.0 36896.8 3970.2 3998.0 4021.8 4022.1 4120.5 27798.0 28015.0 28195.0 28207.0 28249.9 3030.1 3155.9 3241.9 3283.4 3292.5 432603.0 447886.8 453455.0 454618.0 456759.0 45027.8 55153.7 55337.0 55353.7 55383.7 54072.3 54164.2 54168.7 54221.5 54319.0 14882.0 15252.8 15276.7 15318.5 15322.8 9166.0 10609.1 10912.0 11619.7 11872.2 17232.9 17267.7 17269.9 17282.7 17283.0 7140.5 7719.2 8279.3 8303.9 8375.1 860.2 881.6 884.9 904.3 925.3 24034.8 29661.1 29879.6 29937.7 31020.8 1061.8 1067.8 1072.7 1103.3 1108.4 14705.0 15033.0 15627.5 15703.5 15746.4 240800.0 241878.0 242230.6 242374.0 242786.0 58491.7 59015.4 59161.4 59203.8 59227.4 1305.2 1394.9 1434.9 1438.8 1450.1 25267.6 27057.7 27756.4 29844.7 29883.4 45160.8 45321.5 45375.8 45395.3 45492.8 522513.0 523355.0 523372.0 525227.0 526232.0 23005.2 23683.8 25620.6 26069.8 26470.7 45192.9 46009.8 46446.0 46552.4 47334.3 30019.8 33157.3 37874.0 38130.6 38480.9 37192.6 37472.1 37861.0 38086.0 38251.1 36114.5 36381.5 37144.6 37255.4 37331.8 32173.0 33371.2 33631.3 33919.3 33978.0 24941.6 24988.5 25251.7 25258.4 25278.7 11:21:08 INFO - PROCESS | 1640 | 11:21:08 INFO - PROCESS | 1640 | [#2] jquery.html Cycles:180 Average:36337.84 Median:21887.23 stddev:105243.88 (480.8%) stddev-sans-first:105504.46 11:21:08 INFO - PROCESS | 1640 | Values: 366.7 390.1 394.8 401.0 423.6 16248.8 19592.2 20411.8 20864.7 20878.5 20751.3 20816.8 21095.3 21599.2 21845.0 5506.7 5787.5 5789.6 5796.4 5810.9 5589.9 5685.7 5686.8 5703.1 5790.4 4492.8 4937.2 5225.6 5682.6 5683.0 5457.9 5611.2 5657.3 5667.3 5673.7 4993.6 5001.2 5005.8 5012.7 5025.0 21929.5 25988.2 26070.1 26110.5 26262.7 2143.4 2386.4 2695.5 2760.0 2770.7 14734.3 15318.8 15679.9 15715.2 15758.5 1588.8 1818.6 1825.8 1842.6 1843.1 125498.4 126985.0 128413.4 130868.0 130959.0 10870.3 11592.5 11629.7 11653.7 11808.4 12580.2 13095.6 14228.5 14278.9 14287.2 8292.3 8557.4 8627.3 8663.8 8772.0 8537.8 8548.8 8599.1 8648.7 8697.3 7036.2 7113.3 7118.9 7129.7 7139.8 1972.4 2006.2 2006.6 2007.2 2007.7 895.0 911.9 1047.2 1052.2 1103.5 20201.3 21300.5 22429.8 22658.5 22886.1 1057.7 1061.9 1090.8 1091.6 1092.3 9973.8 10568.0 11226.7 11813.5 11845.2 373063.0 486525.6 720826.4 732089.0 735831.0 134423.0 135072.3 136477.0 137243.0 140727.0 997.2 1013.6 1035.4 1038.8 1051.0 16464.0 19444.9 19691.9 19754.2 19853.5 53301.7 54212.7 54504.7 55016.7 55486.0 78402.0 80423.6 80767.6 89467.6 91173.5 8112.8 8219.3 8350.9 8562.4 8649.0 11857.1 13107.6 13404.5 13502.4 13626.0 11115.4 11211.7 11562.6 11713.2 11739.1 9182.2 10822.9 11009.0 11612.9 11729.6 9843.2 11496.0 11810.8 11842.6 11880.9 7463.0 8054.5 8444.9 8469.7 8548.7 9330.0 11301.5 11403.4 11634.5 11683.0 11:21:08 INFO - PROCESS | 1640 | 11:21:08 INFO - PROCESS | 1640 | [#3] mootools.html Cycles:180 Average:5460.76 Median:4998.67 stddev:2987.96 (59.8%) stddev-sans-first:2979.44 11:21:08 INFO - PROCESS | 1640 | Values: 1232.2 1283.2 1456.2 1477.1 1493.2 7613.7 7854.6 8157.3 8595.5 8643.1 8044.7 8166.8 8320.0 8424.6 8455.1 1980.6 1981.0 2307.1 2330.0 2383.2 2096.5 2157.7 2330.6 2363.1 2378.9 2215.5 2283.3 2287.2 2296.6 2315.6 2346.1 2349.2 2349.8 2371.4 2375.0 2332.1 2337.4 2399.5 2400.7 2407.0 8513.4 8556.5 8563.0 8575.7 8595.9 5147.5 5302.9 5309.8 5321.2 5333.1 3399.1 3594.9 3622.4 3631.7 3647.4 1177.0 1212.6 1246.7 1258.7 1265.8 11038.3 11058.2 11139.7 11154.3 11157.5 4644.8 4738.4 4772.0 4773.5 4806.2 9443.4 9511.5 9527.9 9534.2 9555.2 5267.0 5270.8 5273.5 5273.8 5277.9 4594.5 4770.0 4821.7 4916.4 4936.5 3332.9 3835.7 3924.2 3984.5 4000.4 1198.3 1241.4 1269.4 1304.2 1309.9 879.8 887.6 889.3 901.6 915.6 5036.5 5181.8 5411.6 5487.4 5697.9 998.7 1007.6 1014.7 1031.5 1049.6 3604.9 3722.1 3820.5 3832.3 3833.3 9933.8 10220.2 10268.1 10268.1 10274.2 9889.9 10133.1 10150.6 10213.9 10227.5 7843.9 7916.2 7980.7 8011.9 8031.3 5100.7 5441.4 5465.8 5524.2 5540.4 7734.4 9058.3 9299.0 9429.6 9465.6 8683.6 9079.4 9086.0 9477.8 9545.5 7102.6 7258.1 7278.5 7279.7 7304.9 7826.3 7855.3 7871.4 7878.9 7899.7 7058.0 7113.8 7177.6 7217.2 7294.1 7004.1 7017.9 7043.8 7073.8 7115.6 4909.3 6268.6 6335.4 6350.8 6356.0 4937.5 4962.2 4966.2 4966.4 5038.8 4407.2 4851.9 4903.4 4955.9 5031.0 11:21:08 INFO - PROCESS | 1640 | 11:21:08 INFO - PROCESS | 1640 | [#4] prototype.html Cycles:180 Average:4515.50 Median:5029.05 stddev:1370.39 (27.2%) stddev-sans-first:1338.23 11:21:08 INFO - PROCESS | 1640 | Values: 357.8 363.9 371.5 374.4 377.2 4409.9 4575.9 4679.2 5016.0 5197.1 4484.4 4553.4 5237.9 5311.9 5421.4 3640.7 3718.9 4213.4 4218.2 4225.2 3398.9 4004.5 4240.5 4247.8 4251.9 4081.4 4156.6 4160.8 4164.9 4177.6 4136.0 4161.9 4174.5 4175.1 4193.7 3297.8 3524.5 3678.1 3708.3 3710.4 5046.0 5159.9 5165.5 5209.9 5275.8 3901.7 4805.3 4815.0 4822.4 4846.3 5707.3 5729.5 5733.5 5773.9 5789.6 3304.5 3875.2 4072.5 4099.7 4101.9 5758.3 5994.6 5998.6 6004.7 6014.6 3674.5 3785.5 4162.9 4177.5 4181.3 3479.3 3725.7 4075.3 4217.8 4230.2 4127.7 4594.4 4714.3 4847.5 4890.0 4459.2 4846.9 5160.5 5238.8 5676.6 1225.0 1242.8 1256.6 1282.0 1394.7 853.5 880.3 882.9 883.3 890.0 4309.6 4696.6 4748.1 5127.9 5150.3 4737.5 4951.6 5516.3 5564.2 5651.4 4738.7 5039.4 5041.8 5083.7 5115.3 2560.3 2657.7 2923.6 2938.4 2944.5 5467.1 5797.8 5835.6 5867.4 5882.4 4887.3 5218.8 5362.9 5579.9 5766.8 5123.5 5140.5 5562.2 5819.0 5883.0 4728.5 4953.9 5630.4 5672.9 5758.4 5118.4 5176.4 5457.6 5565.9 5579.9 5287.7 5530.9 5566.7 5652.9 5866.0 3239.9 3245.9 3379.0 3491.8 3754.1 4881.4 5175.3 5350.0 5558.7 5627.9 5018.7 5586.7 5649.2 5789.9 5823.5 4686.6 5264.7 5376.9 5720.3 5757.6 5367.6 5514.7 5635.3 5650.8 5661.5 5291.8 5708.3 5719.3 5778.9 5806.7 4987.0 5629.8 5636.1 5661.7 5668.6 11:21:08 INFO - PROCESS | 1640 | 11:21:08 INFO - PROCESS | 1640 | [#5] yui.html Cycles:180 Average:20373.62 Median:23866.30 stddev:29858.52 (125.1%) stddev-sans-first:29905.81 11:21:08 INFO - PROCESS | 1640 | Values: 717.9 774.6 817.4 825.3 826.5 11559.9 15460.8 15686.6 16108.0 16169.0 14675.4 14760.0 14838.4 14869.0 14869.3 685.2 709.5 850.9 865.8 887.0 867.7 881.5 887.0 888.7 892.2 942.6 947.0 947.1 947.5 948.5 919.4 931.7 938.6 940.2 940.7 699.2 701.5 703.5 704.9 705.7 14541.1 14619.6 14695.3 15564.0 16070.0 12024.0 14622.6 14860.5 14885.3 15288.4 11685.4 11804.6 11884.3 11981.7 12273.1 3715.9 3754.7 3791.6 3900.0 3901.4 112147.0 112215.0 114306.1 115476.0 116950.4 11135.7 11150.3 11256.4 11295.8 11652.2 23701.8 23908.2 24279.4 24305.5 24305.8 7823.0 7827.8 7847.2 7896.0 7967.0 4246.1 4291.2 4310.2 4367.8 4458.0 3126.7 3526.8 3603.3 3629.9 3634.1 650.7 651.6 659.2 665.6 675.3 605.5 664.6 690.9 725.5 729.6 9794.9 10312.2 10353.4 10385.2 10519.3 700.6 714.5 715.9 716.4 721.1 4649.5 5054.9 5070.9 5087.8 5099.2 98673.5 99201.0 100655.0 103086.0 106436.5 61435.7 77827.6 89677.8 93733.0 94114.5 78597.2 79560.6 79633.0 80709.6 82493.0 8250.7 8342.9 9780.3 9812.7 9815.9 43364.8 45963.6 48448.0 49584.8 53532.7 65053.7 67330.0 68363.0 68532.7 70279.3 11926.2 11937.9 11946.1 12009.0 12020.0 10310.4 10646.4 12809.2 12870.1 13052.5 11914.6 12042.3 12263.9 12460.4 12468.3 11897.9 12071.3 12151.8 12476.9 12520.2 11791.0 11924.8 12217.0 12443.1 12527.9 10010.2 10123.5 10141.0 10222.9 10515.7 8920.9 9690.3 9731.1 9747.0 9749.8 11:21:08 INFO - PROCESS | 1640 | -------- Summary: end -------- 11:21:08 INFO - PROCESS | 1640 | 11:21:09 INFO - TEST-INFO | 1640: exit 0 11:21:09 INFO - TEST-OK | dromaeo_css | took 1115119ms 11:21:09 INFO - TEST-START | kraken 11:21:09 INFO - operating with platform_type : mac_ 11:21:09 INFO - Initialising browser for kraken test... 11:21:09 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/tmpzvpcTl/profile http://localhost:49242/getInfo.html) 11:21:11 INFO - PROCESS | 1651 | 2017-01-14 11:21:11.973 plugin-container[1652:10100] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b4f, name = 'com.apple.tsm.portname' 11:21:11 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:21:11 INFO - PROCESS | 1651 | 2017-01-14 11:21:11.977 plugin-container[1652:10100] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 11:21:11 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:21:11 INFO - PROCESS | 1651 | 2017-01-14 11:21:11.977 plugin-container[1652:10100] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:21:12 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 11:21:12 INFO - PROCESS | 1651 | colorDepth:24 11:21:12 INFO - PROCESS | 1651 | Browser inner width/height: 1024/663 11:21:12 INFO - PROCESS | 1651 | __metrics 11:21:12 ERROR - PROCESS | 1651 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3249: TypeError: this.tabs is undefined 11:21:12 INFO - TEST-INFO | 1651: exit 0 11:21:12 INFO - Browser initialized. 11:21:12 INFO - Running cycle 1/1 for kraken test... 11:21:12 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/tmpzvpcTl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:21:15 INFO - PROCESS | 1653 | 2017-01-14 11:21:15.345 plugin-container[1654:10218] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x433b, name = 'com.apple.tsm.portname' 11:21:15 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:21:15 INFO - PROCESS | 1653 | 2017-01-14 11:21:15.345 plugin-container[1654:10218] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f03, name = 'com.apple.CFPasteboardClient' 11:21:15 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:21:15 INFO - PROCESS | 1653 | 2017-01-14 11:21:15.345 plugin-container[1654:10218] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:21:25 INFO - PROCESS | 1653 | RSS: Main: 243236864 11:21:25 INFO - PROCESS | 1653 | 11:21:28 INFO - PROCESS | 1653 | 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) 11:21:28 INFO - PROCESS | 1653 | RSS: Main: 253390848 11:21:28 INFO - PROCESS | 1653 | 11:21:31 INFO - PROCESS | 1653 | 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) 11:21:32 INFO - PROCESS | 1653 | RSS: Main: 261226496 11:21:32 INFO - PROCESS | 1653 | 11:21:35 INFO - PROCESS | 1653 | 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) 11:21:36 INFO - PROCESS | 1653 | RSS: Main: 262348800 11:21:36 INFO - PROCESS | 1653 | 11:21:38 INFO - PROCESS | 1653 | 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) 11:21:38 INFO - PROCESS | 1653 | RSS: Main: 262942720 11:21:38 INFO - PROCESS | 1653 | 11:21:40 INFO - PROCESS | 1653 | 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) 11:21:41 INFO - PROCESS | 1653 | RSS: Main: 263790592 11:21:41 INFO - PROCESS | 1653 | 11:21:44 INFO - PROCESS | 1653 | 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) 11:21:45 INFO - PROCESS | 1653 | RSS: Main: 268644352 11:21:45 INFO - PROCESS | 1653 | 11:21:48 INFO - PROCESS | 1653 | 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) 11:21:48 INFO - PROCESS | 1653 | RSS: Main: 267644928 11:21:48 INFO - PROCESS | 1653 | 11:21:51 INFO - PROCESS | 1653 | 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) 11:21:52 INFO - PROCESS | 1653 | RSS: Main: 267767808 11:21:52 INFO - PROCESS | 1653 | 11:21:54 INFO - PROCESS | 1653 | 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) 11:21:54 INFO - PROCESS | 1653 | RSS: Main: 267259904 11:21:54 INFO - PROCESS | 1653 | 11:21:56 INFO - PROCESS | 1653 | 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) 11:21:57 INFO - PROCESS | 1653 | RSS: Main: 267292672 11:21:57 INFO - PROCESS | 1653 | 11:21:59 INFO - PROCESS | 1653 | 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) 11:22:00 INFO - PROCESS | 1653 | RSS: Main: 267321344 11:22:00 INFO - PROCESS | 1653 | 11:22:03 INFO - PROCESS | 1653 | 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) 11:22:04 INFO - PROCESS | 1653 | RSS: Main: 267579392 11:22:04 INFO - PROCESS | 1653 | 11:22:07 INFO - PROCESS | 1653 | 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) 11:22:07 INFO - PROCESS | 1653 | RSS: Main: 267403264 11:22:07 INFO - PROCESS | 1653 | 11:22:09 INFO - PROCESS | 1653 | 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) 11:22:09 INFO - PROCESS | 1653 | RSS: Main: 269332480 11:22:09 INFO - PROCESS | 1653 | 11:22:09 INFO - PROCESS | 1653 | __start_tp_report 11:22:09 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 11:22:09 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 11:22:09 INFO - PROCESS | 1653 | |i|pagename|runs| 11:22:09 INFO - PROCESS | 1653 | |0;ai-astar;107;116;115;118;116;118;118;116;118;117 11:22:09 INFO - PROCESS | 1653 | |1;audio-beat-detection;144;114;112;160;113;98;126;143;138;144 11:22:09 INFO - PROCESS | 1653 | |2;audio-dft;201;203;234;287;273;197;200;199;192;196 11:22:09 INFO - PROCESS | 1653 | |3;audio-fft;83;62;78;109;68;59;59;68;64;60 11:22:09 INFO - PROCESS | 1653 | |4;audio-oscillator;114;103;116;102;69;73;82;70;71;82 11:22:09 INFO - PROCESS | 1653 | |5;imaging-gaussian-blur;88;85;88;86;105;92;119;85;104;108 11:22:09 INFO - PROCESS | 1653 | |6;imaging-darkroom;96;96;98;154;95;96;108;97;96;119 11:22:09 INFO - PROCESS | 1653 | |7;imaging-desaturate;107;96;130;89;143;89;80;142;146;97 11:22:09 INFO - PROCESS | 1653 | |8;json-parse-financial;53;68;96;92;79;61;63;62;62;62 11:22:09 INFO - PROCESS | 1653 | |9;json-stringify-tinderbox;71;105;103;100;80;71;71;69;70;74 11:22:09 INFO - PROCESS | 1653 | |10;stanford-crypto-aes;99;108;113;106;89;87;90;87;84;98 11:22:09 INFO - PROCESS | 1653 | |11;stanford-crypto-ccm;158;151;147;163;142;145;160;146;201;195 11:22:09 INFO - PROCESS | 1653 | |12;stanford-crypto-pbkdf2;175;175;174;172;196;236;200;175;172;248 11:22:09 INFO - PROCESS | 1653 | |13;stanford-crypto-sha256-iterative;70;68;67;67;68;69;67;68;67;67 11:22:09 INFO - PROCESS | 1653 | __end_tp_report 11:22:09 INFO - PROCESS | 1653 | __start_cc_report 11:22:09 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,909 11:22:09 INFO - PROCESS | 1653 | __end_cc_report 11:22:09 INFO - PROCESS | 1653 | __startTimestamp1484421729951__endTimestamp 11:22:09 INFO - PROCESS | 1653 | 11:22:09 INFO - PROCESS | 1653 | ------- Summary: start ------- 11:22:09 INFO - PROCESS | 1653 | Number of tests: 14 11:22:09 INFO - PROCESS | 1653 | 11:22:09 INFO - PROCESS | 1653 | [#0] ai-astar Cycles:10 Average:115.90 Median:117.50 stddev:3.31 (2.8%) stddev-sans-first:1.17 11:22:09 INFO - PROCESS | 1653 | Values: 107.0 116.0 115.0 118.0 116.0 118.0 118.0 116.0 118.0 117.0 11:22:09 INFO - PROCESS | 1653 | 11:22:09 INFO - PROCESS | 1653 | [#1] audio-beat-detection Cycles:10 Average:129.20 Median:143.50 stddev:19.52 (13.6%) stddev-sans-first:19.95 11:22:09 INFO - PROCESS | 1653 | Values: 144.0 114.0 112.0 160.0 113.0 98.0 126.0 143.0 138.0 144.0 11:22:09 INFO - PROCESS | 1653 | 11:22:09 INFO - PROCESS | 1653 | [#2] audio-dft Cycles:10 Average:218.20 Median:202.00 stddev:34.71 (17.2%) stddev-sans-first:36.25 11:22:09 INFO - PROCESS | 1653 | Values: 201.0 203.0 234.0 287.0 273.0 197.0 200.0 199.0 192.0 196.0 11:22:09 INFO - PROCESS | 1653 | 11:22:09 INFO - PROCESS | 1653 | [#3] audio-fft Cycles:10 Average:71.00 Median:66.00 stddev:15.61 (23.7%) stddev-sans-first:15.95 11:22:09 INFO - PROCESS | 1653 | Values: 83.0 62.0 78.0 109.0 68.0 59.0 59.0 68.0 64.0 60.0 11:22:09 INFO - PROCESS | 1653 | 11:22:09 INFO - PROCESS | 1653 | [#4] audio-oscillator Cycles:10 Average:88.20 Median:70.50 stddev:18.71 (26.5%) stddev-sans-first:17.36 11:22:09 INFO - PROCESS | 1653 | Values: 114.0 103.0 116.0 102.0 69.0 73.0 82.0 70.0 71.0 82.0 11:22:09 INFO - PROCESS | 1653 | 11:22:09 INFO - PROCESS | 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:96.00 Median:85.50 stddev:12.04 (14.1%) stddev-sans-first:12.41 11:22:09 INFO - PROCESS | 1653 | Values: 88.0 85.0 88.0 86.0 105.0 92.0 119.0 85.0 104.0 108.0 11:22:09 INFO - PROCESS | 1653 | 11:22:09 INFO - PROCESS | 1653 | [#6] imaging-darkroom Cycles:10 Average:105.50 Median:96.00 stddev:18.68 (19.5%) stddev-sans-first:19.49 11:22:09 INFO - PROCESS | 1653 | Values: 96.0 96.0 98.0 154.0 95.0 96.0 108.0 97.0 96.0 119.0 11:22:09 INFO - PROCESS | 1653 | 11:22:09 INFO - PROCESS | 1653 | [#7] imaging-desaturate Cycles:10 Average:111.90 Median:84.50 stddev:25.67 (30.4%) stddev-sans-first:27.16 11:22:09 INFO - PROCESS | 1653 | Values: 107.0 96.0 130.0 89.0 143.0 89.0 80.0 142.0 146.0 97.0 11:22:09 INFO - PROCESS | 1653 | 11:22:09 INFO - PROCESS | 1653 | [#8] json-parse-financial Cycles:10 Average:69.80 Median:65.50 stddev:14.36 (21.9%) stddev-sans-first:13.88 11:22:09 INFO - PROCESS | 1653 | Values: 53.0 68.0 96.0 92.0 79.0 61.0 63.0 62.0 62.0 62.0 11:22:09 INFO - PROCESS | 1653 | 11:22:09 INFO - PROCESS | 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:81.40 Median:71.00 stddev:15.03 (21.2%) stddev-sans-first:15.47 11:22:09 INFO - PROCESS | 1653 | Values: 71.0 105.0 103.0 100.0 80.0 71.0 71.0 69.0 70.0 74.0 11:22:09 INFO - PROCESS | 1653 | 11:22:09 INFO - PROCESS | 1653 | [#10] stanford-crypto-aes Cycles:10 Average:96.10 Median:88.00 stddev:10.20 (11.6%) stddev-sans-first:10.77 11:22:09 INFO - PROCESS | 1653 | Values: 99.0 108.0 113.0 106.0 89.0 87.0 90.0 87.0 84.0 98.0 11:22:09 INFO - PROCESS | 1653 | 11:22:09 INFO - PROCESS | 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:160.80 Median:159.00 stddev:20.84 (13.1%) stddev-sans-first:22.08 11:22:09 INFO - PROCESS | 1653 | Values: 158.0 151.0 147.0 163.0 142.0 145.0 160.0 146.0 201.0 195.0 11:22:09 INFO - PROCESS | 1653 | 11:22:09 INFO - PROCESS | 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:192.30 Median:185.50 stddev:28.17 (15.2%) stddev-sans-first:29.18 11:22:09 INFO - PROCESS | 1653 | Values: 175.0 175.0 174.0 172.0 196.0 236.0 200.0 175.0 172.0 248.0 11:22:09 INFO - PROCESS | 1653 | 11:22:09 INFO - PROCESS | 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:1.03 (1.5%) stddev-sans-first:0.73 11:22:09 INFO - PROCESS | 1653 | Values: 70.0 68.0 67.0 67.0 68.0 69.0 67.0 68.0 67.0 67.0 11:22:09 INFO - PROCESS | 1653 | -------- Summary: end -------- 11:22:09 INFO - PROCESS | 1653 | 11:22:10 INFO - TEST-INFO | 1653: exit 0 11:22:10 INFO - TEST-OK | kraken | took 61565ms 11:22:10 INFO - SUITE-END | took 1176s 11:22:11 INFO - Completed test suite (00:19:36) 11:22:11 INFO - javascript benchmark 11:22:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7268.856409993508, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2684.0337478507736, 3163.5096560033194, 3383.5432216650743, 3388.542546756187, 3424.743144264179, 5467.753951072212, 5626.831195064145, 5733.455321744433, 5737.0, 5750.338711048231, 5647.915281270784, 5723.828285151452, 5807.477327040566, 5860.648361098337, 5882.735276912538, 5212.765425555859, 5278.762455689484, 5281.970015846901, 5290.7354632268425, 5325.121354976424, 5233.764480598382, 5350.250964864922, 5353.678779273237, 5372.623916325859, 5386.976474469858, 5319.9734001330135, 5334.306540149775, 5337.4662533746705, 5344.118220493614, 5346.572274218053, 5136.9743151284, 5163.302954101224, 5175.430702622709, 5203.19350500673, 5280.2079688046715, 5184.559312458446, 5185.429602743695, 5206.323177986837, 5273.841784746463, 5307.097793375136, 4415.735055896656, 5650.208970744099, 5746.597738158331, 5824.126381042835, 5827.300723913115, 6185.134081228632, 6197.5351848611535, 6204.069389591597, 6275.309715931244, 6356.110144579762, 6240.906386404207, 6303.401176888188, 6308.211473565804, 6333.8416539586415, 6340.524460665469, 5993.280806303272, 6020.548458865603, 6037.72830222641, 6041.063635136561, 6078.057901025348, 6208.689565521706, 6276.623402595859, 6333.778317758856, 6341.8097457076365, 6371.299157092716, 4896.4858689837765, 6104.877902441926, 6157.4458298753325, 6265.342139075331, 6277.780277690259, 6272.278687950853, 6292.182016337847, 6300.558960872787, 6326.652034138075, 6333.746650134035, 6145.40219542922, 6175.907361389583, 6194.566380353423, 6224.346443623445, 6302.684865756693, 6288.245410550763, 6292.968535157386, 6294.433500984934, 6330.208723909512, 6334.904976425358, 4993.975030124899, 5027.622928280393, 5029.06962211992, 5045.041442125985, 5058.949410505921, 4383.671224658164, 4464.531224221475, 4481.686281960297, 4500.617447516997, 4501.864944051684, 5915.881682366328, 5979.0, 6018.247719035121, 6025.216721826135, 6095.05526643371, 6290.811275661737, 6292.150559674477, 6297.590656607306, 6311.274203466568, 6313.43179113882, 5693.914591281134, 5768.884622307531, 5957.970210149008, 5975.79084732041, 6034.125051867454, 5424.105022671294, 5473.0, 5479.972600136974, 5481.616286859881, 5501.5323697486165, 5650.943490565041, 6255.093011513305, 6423.582467139621, 6430.2605200400685, 6436.259830119502, 5215.800365915785, 5861.32594751609, 6274.592151510137, 6278.591891527036, 6299.401556852092, 6201.503879689704, 6259.12372267892, 6361.936380636134, 6377.553571249968, 6465.224173099258, 5400.972995134999, 6172.722227499684, 6184.5980011299125, 6234.220722409699, 6238.563300569098, 6223.502119830312, 6230.06549017651, 6238.220222472191, 6255.218097737783, 6266.624002559679, 6034.336223015377, 6152.907706384318, 6229.159063526366, 6233.594816336924, 6237.4698150657705, 5966.76132954677, 6101.792513241593, 6112.625067133501, 6143.784967526115, 6186.1648677427975, 5951.047832346804, 5954.821355359346, 6003.90994135097, 6106.491003209229, 6118.314626315779, 6112.077967281658, 6113.32428171423, 6118.296395914527, 6132.845047373448, 6132.846678833065, 5989.4310040547825, 6041.456268935641, 6044.395560444096, 6056.485198758155, 6061.605995610271], "value": 5733.234372663466, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [442.6259810460162, 456.9680122391432, 474.2554189921823, 486.20748180465836, 496.7119070938856, 38200.42699359509, 40757.59242407579, 40884.59115408845, 42663.72008839732, 42854.14291714164, 41150.58849411512, 41449.0, 41717.16565668685, 41767.95580110499, 41778.0, 9197.264218862474, 9424.198943089845, 9442.858357124614, 10824.0, 11220.438978051106, 11010.449477526132, 11105.666829995112, 11111.83332250017, 11115.944420277887, 11126.777464450706, 10581.78836423271, 11110.722231944226, 11118.888811111867, 11145.16411269154, 11148.275362101438, 11066.612668556601, 11079.113670906308, 11089.72275693102, 11093.16801239902, 11116.555337786478, 10977.725556861142, 11047.116230701524, 11056.668299951014, 11059.72350691231, 11065.889341106647, 36507.63492365069, 36683.26633467316, 36847.815760921025, 36856.0, 36896.81551592251, 3970.245653325888, 3997.960020399788, 4021.8391264349393, 4022.1352409231863, 4120.526139493966, 27798.0, 28015.0, 28195.0, 28207.012754553696, 28249.858750706117, 3030.0606811888383, 3155.9053228403186, 3241.8541165647603, 3283.40898638245, 3292.489664102068, 432603.0, 447886.7605661983, 453455.0, 454618.0, 456759.0, 45027.77486112549, 55153.72423137858, 55337.0, 55353.72323138439, 55383.723081384334, 54072.29638518058, 54164.187537186976, 54168.72915635397, 54221.457785422426, 54319.0, 14882.0, 15252.771208431883, 15276.694466110615, 15318.463853765288, 15322.846771532364, 9165.954170229106, 10609.098226650667, 10912.0, 11619.6514104577, 11872.168948173718, 17232.913835430994, 17267.65464690699, 17269.87745796519, 17282.65434691299, 17283.049432281096, 7140.500164988401, 7719.189485104095, 8279.254867061993, 8303.916960830435, 8375.120612335739, 860.2300940658076, 881.6076845803684, 884.8894637230235, 904.2585080234277, 925.3291363761219, 24034.7596524036, 29661.110166695034, 29879.551806722917, 29937.700622993925, 31020.844895775826, 1061.7717190804015, 1067.8291473364225, 1072.7371793910386, 1103.3214573037685, 1108.3737688206138, 14704.970652054468, 15033.0, 15627.531174064796, 15703.450379236672, 15746.448874289345, 240800.0, 241878.0, 242230.57769422434, 242374.0, 242786.0, 58491.70754146202, 59015.40984590185, 59161.40838591559, 59203.815923682145, 59227.40772592219, 1305.236436684531, 1394.909330893509, 1434.9210793406462, 1438.8345340286, 1450.1154295879505, 25267.62098568486, 27057.72942270552, 27756.44487110206, 29844.701552984192, 29883.402331952806, 45160.77419612881, 45321.54678453173, 45375.773121135506, 45395.319070213314, 45492.77253613843, 522513.0, 523355.0, 523372.0, 525227.0, 526232.0, 23005.194818181284, 23683.763162368847, 25620.61569076428, 26069.826857791824, 26470.735292646827, 45192.87017824581, 46009.849753756425, 46446.0, 46552.41371035362, 47334.28998564956, 30019.799208031432, 33157.33685326328, 37874.0, 38130.61869381271, 38480.8571555955, 37192.628073718915, 37472.063198420256, 37861.0, 38086.047848804, 38251.133506247235, 36114.4582831263, 36381.454278185316, 37144.628553714116, 37255.44116838304, 37331.81334093312, 32173.0, 33371.16572085717, 33631.327373452885, 33919.321613568085, 33978.0, 24941.625875612244, 24988.50022999566, 25251.74748252494, 25258.36854078663, 25278.74721252764], "value": 19096.97137558438, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.6736604422064, 390.1280637774573, 394.84206317473024, 400.997995010025, 423.62085933089884, 16248.83751162488, 19592.216311347547, 20411.775293482366, 20864.687029694567, 20878.478038049037, 20751.273705420313, 20816.791832081675, 21095.2616658417, 21599.244026459077, 21845.0, 5506.669599824013, 5787.450192231752, 5789.565782566303, 5796.362400135981, 5810.9418905811035, 5589.916151257735, 5685.687287199203, 5686.829395118153, 5703.144528320744, 5790.420957904197, 4492.775361231942, 4937.185364414885, 5225.63420560559, 5682.607761098516, 5682.971585142089, 5457.945420545783, 5611.186377975211, 5657.264555607765, 5667.291588551431, 5673.744681489343, 4993.6005119590345, 5001.249812528114, 5005.849824505271, 5012.749362531858, 5025.0, 21929.451763705874, 25988.220353389428, 26070.087546935956, 26110.477790444274, 26262.737372626412, 2143.3569929021232, 2386.4391867911027, 2695.5417579011614, 2759.951218536963, 2770.667519897625, 14734.263286835723, 15318.846811531854, 15679.92160039204, 15715.192752833456, 15758.527244182693, 1588.849059339361, 1818.5908170661628, 1825.790034146077, 1842.6406850664125, 1843.0508288231572, 125498.37250813779, 126985.0, 128413.35793320973, 130868.0, 130959.0, 10870.293430926964, 11592.47833847479, 11629.709257268467, 11653.708657283636, 11808.409579520989, 12580.245185288912, 13095.607131786062, 14228.502002429865, 14278.857211427752, 14287.214203218922, 8292.33661307094, 8557.358198135165, 8627.309815214769, 8663.826723465496, 8772.0, 8537.786555336166, 8548.786280343042, 8599.14008599135, 8648.654053837901, 8697.304215662733, 7036.226015138331, 7113.288671132948, 7118.92881071193, 7129.714811407485, 7139.82150446243, 1972.447714639903, 2006.2476571285767, 2006.6087113012823, 2007.197121151551, 2007.718919351292, 894.9886628110324, 911.9316051296047, 1047.1727335404944, 1052.2476429353048, 1103.4648195625116, 20201.292954746514, 21300.467488312606, 22429.775702243096, 22658.546829063656, 22886.08455661755, 1057.7408534908996, 1061.8991195836384, 1090.7818436312768, 1091.5579190427732, 1092.2627226622158, 9973.80052398948, 10568.0, 11226.7193320166, 11813.527458901719, 11845.170838041255, 373063.0, 486525.56737216085, 720826.3958680173, 732089.0, 735831.0, 134423.0, 135072.3246383762, 136477.0, 137243.0, 140727.0, 997.2221667099674, 1013.5945621751358, 1035.3684252605904, 1038.8234000219982, 1050.9842352364722, 16464.014952747668, 19444.930528820485, 19691.916944568187, 19754.209831606575, 19853.503662408555, 53301.73349133385, 54212.728936355066, 54504.727476362365, 55016.72491637516, 55486.0, 78402.0, 80423.59788201022, 80767.59616202116, 89467.55266223887, 91173.54413227891, 8112.83774324522, 8219.301359384519, 8350.916490835258, 8562.400631955952, 8649.0, 11857.11071669611, 13107.606771796862, 13404.530841420503, 13502.392392342172, 13626.0, 11115.388653624128, 11211.66365009051, 11562.595309164139, 11713.238639488405, 11739.11956603241, 9182.219511341611, 10822.945885270523, 11009.0, 11612.88387116118, 11729.648110556696, 9843.208186351394, 11496.022838058858, 11810.822837657613, 11842.585509507126, 11880.940595296968, 7462.96268518654, 8054.509915665386, 8444.873326900224, 8469.74590762278, 8548.74353769388, 9330.0, 11301.547938082385, 11403.429828508708, 11634.476448559666, 11683.0], "value": 9947.211866651987, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1232.1929136415647, 1283.2172374851345, 1456.1772598481857, 1477.135875512825, 1493.1936754152757, 7613.7335193268245, 7854.607269636524, 8157.347412207024, 8595.527246001475, 8643.141724529225, 8044.6782128714785, 8166.79583010425, 8320.0, 8424.578771061453, 8455.112213217615, 1980.5840773437596, 1980.9603807923834, 2307.1348244408305, 2329.974811083118, 2383.177803657744, 2096.4758810297426, 2157.7410710714657, 2330.6270996640455, 2363.125643511903, 2378.892949817254, 2215.4793623498463, 2283.303592404316, 2287.176616418088, 2296.59809533331, 2315.5600435917204, 2346.143657564985, 2349.1895296122725, 2349.788519033278, 2371.383440305533, 2374.964375534368, 2332.148765700524, 2337.403961989699, 2399.472116134448, 2400.663907053014, 2406.987965060181, 8513.404061715682, 8556.48661080331, 8563.0, 8575.742727718178, 8595.914040859636, 5147.510986456281, 5302.92045619316, 5309.787608495694, 5321.175217841241, 5333.120035194188, 3399.1162297802503, 3594.9101272468138, 3622.4385220290897, 3631.7457777955287, 3647.416413373874, 1177.0223900861554, 1212.563477148226, 1246.7132559511363, 1258.7293731847697, 1265.7848165811833, 11038.337699738042, 11058.170637202242, 11139.721506962309, 11154.330740155616, 11157.497912593954, 4644.815572029111, 4738.360321356642, 4771.976140119277, 4773.498782627844, 4806.2310030394965, 9443.386179898285, 9511.476868772146, 9527.90472095284, 9534.23726101924, 9555.23558115349, 5266.97366513165, 5270.8155214567305, 5273.5253827154975, 5273.815416460482, 5277.920831187535, 4594.540545945379, 4769.976150119297, 4821.734804585712, 4916.385451818523, 4936.531029552187, 3332.8833490828188, 3835.712321575893, 3924.1955399143108, 3984.5019372578427, 4000.4199391088127, 1198.3289357959395, 1241.3669028795198, 1269.4033804112053, 1304.1914013311807, 1309.9148555343872, 879.7536689726886, 887.6227603268585, 889.2707979456783, 901.5695279461711, 915.6200176926501, 5036.521530454675, 5181.81863634771, 5411.648242864201, 5487.368952570506, 5697.914531282034, 998.6804222648683, 1007.6271779441654, 1014.7361685961555, 1031.515187861704, 1049.6483677967967, 3604.9098772530374, 3722.10669439338, 3820.471811275512, 3832.3293423651307, 3833.271678381099, 9933.751656208653, 10220.233482488844, 10268.127209187154, 10268.127209187154, 10274.22943279257, 9889.851652225223, 10133.138683211862, 10150.593976240867, 10213.94893025545, 10227.539760710786, 7843.882341764764, 7916.168802275678, 7980.720674776355, 8011.919880801117, 8031.277185053374, 5100.668456550312, 5441.428649991693, 5465.808696695596, 5524.226608274925, 5540.390557038642, 7734.381249500139, 9058.320625952949, 9299.0, 9429.575669095044, 9465.574049167666, 8683.609237584451, 9079.409838360485, 9086.0, 9477.810443791224, 9545.474998875128, 7102.573845569283, 7258.129024517092, 7278.526895751759, 7279.745208917662, 7304.890426643711, 7826.256505631955, 7855.293023627901, 7871.448998570045, 7878.881816772639, 7899.68401263943, 7058.0, 7113.822154445973, 7177.641117944187, 7217.206107328295, 7294.1247050354295, 7004.0544526488275, 7017.894731578928, 7043.7534686285735, 7073.752418665322, 7115.573065615872, 4909.288153217834, 6268.561200716089, 6335.429811317003, 6350.809475715736, 6356.0, 4937.506249375034, 4962.206047032601, 4966.205407134841, 4966.379202599675, 5038.823641172541, 4407.2067027934, 4851.902961940671, 4903.362562866804, 4955.851324460272, 5030.968651426522], "value": 4443.114218489475, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.79963220596466, 363.9490471334013, 371.45767179917317, 374.36171327885955, 377.2059814091336, 4409.897525618595, 4575.88560285993, 4679.227927391977, 5015.999999999995, 5197.116490196666, 4484.372187893689, 4553.385292985446, 5237.921431178535, 5311.920321195175, 5421.430749771276, 3640.7087433005427, 3718.888433347004, 4213.410122582825, 4218.219629368561, 4225.239456897757, 3398.9150271243293, 4004.537209616094, 4240.533541310453, 4247.8300867965245, 4251.936220956688, 4081.4490043844, 4156.625903668669, 4160.771157586331, 4164.937525937114, 4177.582241775814, 4135.97932010341, 4161.875143745692, 4174.519930208035, 4175.102352994121, 4193.6645068394455, 3297.7526685498683, 3524.4713293006, 3678.1241566801123, 3708.295423869456, 3710.406334986389, 5046.0, 5159.922601160985, 5165.509276618715, 5209.921851172236, 5275.815346462856, 3901.6785012917267, 4805.303231031481, 4814.975925120387, 4822.397200349957, 4846.29728689338, 5707.315122185364, 5729.484346408802, 5733.505924922631, 5773.9422605773825, 5789.565782566325, 3304.487804390323, 3875.2249550090096, 4072.53165885921, 4099.733517321364, 4101.876943691694, 5758.337791154029, 5994.580379373446, 5998.590331272191, 6004.669743164124, 6014.609050411709, 3674.52231209941, 3785.523645778149, 4162.854300099482, 4177.456930599003, 4181.268278051329, 3479.321532301177, 3725.6646901778427, 4075.3071977763852, 4217.810198541073, 4230.2174097792, 4127.669786417079, 4594.425696787902, 4714.339992401066, 4847.473045990501, 4890.046440943982, 4459.2163134745715, 4846.909445374833, 5160.509751573594, 5238.842834714965, 5676.552479117881, 1224.9848998397586, 1242.7510352096085, 1256.5539233572133, 1281.9615411537668, 1394.6583087143513, 853.5262929074423, 880.2869675562814, 882.9426087304305, 883.2801266967401, 890.0, 4309.569043095728, 4696.577308042292, 4748.121597504472, 5127.948720512747, 5150.253213284052, 4737.455192652889, 4951.603871690256, 5516.3380394352935, 5564.1931919871395, 5651.350094739158, 4738.739369334719, 5039.370078740158, 5041.773120209526, 5083.694978301313, 5115.309433226466, 2560.3215147985798, 2657.720939301384, 2923.5906973023793, 2938.4416960777385, 2944.4994350960387, 5467.125259958467, 5797.768089276466, 5835.5915085944425, 5867.442592953663, 5882.352941176488, 4887.2650209175945, 5218.817341393033, 5362.919556206582, 5579.9163012554845, 5766.769329226868, 5123.513266239701, 5140.511651393186, 5562.249096371938, 5818.970905145447, 5883.0, 4728.456227533878, 4953.869835970568, 5630.408807075362, 5672.858178545569, 5758.400999375391, 5118.370388771581, 5176.4305926348825, 5457.61796674229, 5565.860853478695, 5579.944200558105, 5287.709175995204, 5530.861728456821, 5566.749496272597, 5652.943470565407, 5866.005558110263, 3239.9190020249684, 3245.8539365728125, 3378.9525247172473, 3491.8079505627434, 3754.099016236029, 4881.414230292387, 5175.257113729729, 5349.956758432068, 5558.749856256397, 5627.88744225105, 5018.723970181675, 5586.748596313257, 5649.237352957298, 5789.8552536186935, 5823.505002074871, 4686.554777296152, 5264.657797243167, 5376.892462150813, 5720.2839148254525, 5757.596968212352, 5367.577591938218, 5514.6691198528215, 5635.323761148688, 5650.830475085754, 5661.490465858093, 5291.76187071575, 5708.258981010831, 5719.28508936383, 5778.884422311614, 5806.709664516673, 4986.982875360355, 5629.774809007594, 5636.126400407943, 5661.745221465127, 5668.603197776281], "value": 4093.454497875006, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [717.9353858152768, 774.6126936531731, 817.395127605572, 825.3397282174261, 826.5206180415362, 11559.942200289008, 15460.845391546081, 15686.607834804136, 16108.033517988928, 16169.029858208502, 14675.412983480675, 14759.966802323841, 14838.406463741465, 14869.0, 14869.256537173125, 685.2325395556958, 709.5033476566398, 850.8893843800329, 865.7965378136133, 887.0331338840663, 867.6789587852503, 881.5195718333524, 887.0, 888.6578667213137, 892.1836519584572, 942.604106275366, 947.010374159002, 947.1381043250643, 947.5167664491124, 948.5446985446989, 919.4207649180973, 931.7018554062703, 938.6151677812098, 940.1538615246264, 940.6736501532874, 699.220369288245, 701.5404909784099, 703.4583370804503, 704.9224585295614, 705.693023534764, 14541.054831435922, 14619.63450913725, 14695.338709758087, 15564.0, 16070.035797852166, 12024.0, 14622.634434139125, 14860.52358528215, 14885.33016014282, 15288.388464461408, 11685.357305348203, 11804.586839460577, 11884.286942783374, 11981.700457488545, 12273.079519036108, 3715.888523344277, 3754.699624030098, 3791.563970143441, 3900.0054985978677, 3901.375779875235, 112147.0, 112215.0, 114306.14234644118, 115476.0, 116950.41524792321, 11135.665930022113, 11150.330980141056, 11256.437178141061, 11295.774084518263, 11652.242604230698, 23701.762982369957, 23908.163214287415, 24279.39301517441, 24305.513889722108, 24305.75694243035, 7823.0, 7827.843443131105, 7847.176046515148, 7895.960520197362, 7966.960165199137, 4246.10831725335, 4291.249031419489, 4310.202612516632, 4367.82068841411, 4457.977710111493, 3126.7024184962984, 3526.84129214186, 3603.261331427051, 3629.854805807791, 3634.055145662147, 650.681166228554, 651.635084352764, 659.1840370568251, 665.6139439125295, 675.3314218923231, 605.5004621187538, 664.5613894829389, 690.944724422045, 725.5320318394606, 729.6424751871544, 9794.853077203848, 10312.175025997902, 10353.4305613192, 10385.169186465064, 10519.304280395578, 700.6111608057475, 714.5248409807524, 715.853250083742, 716.3544414472144, 721.0770214125927, 4649.488556258809, 5054.949450505522, 5070.923936140961, 5087.821926232638, 5099.23511473282, 98673.50663246638, 99201.0, 100655.0, 103086.0, 106436.46781766042, 61435.6928215365, 77827.61086194533, 89677.75805604912, 93733.0, 94114.52942735242, 78597.214027859, 79560.60219698865, 79633.0, 80709.5964520162, 82493.0, 8250.669973201006, 8342.87485687703, 9780.26648001417, 9812.65655702047, 9815.852762208715, 43364.78317608392, 45963.62109136731, 48448.0, 49584.75207623939, 53532.73233633963, 65053.67473162604, 67330.0, 68363.0, 68532.657336713, 70279.29720702728, 11926.224795388272, 11937.880621194025, 11946.104042196695, 12009.0, 12020.0, 10310.432926188832, 10646.361218326925, 12809.231446113263, 12870.099093063396, 13052.477900883858, 11914.642560723192, 12042.337671428155, 12263.93868030654, 12460.376981151088, 12468.314242716737, 11897.881021189678, 12071.336076515876, 12151.81772273399, 12476.937615311865, 12520.248785072925, 11791.0, 11924.821127683264, 12216.961558267647, 12443.128980971245, 12527.87472125267, 10010.249231307535, 10123.470252640413, 10140.995948164298, 10222.897771022492, 10515.684529464128, 8920.86618700733, 9690.273229507675, 9731.124198821857, 9747.0, 9749.805003900025], "value": 7445.737294284432, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1604.0999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 116.0, 115.0, 118.0, 116.0, 118.0, 118.0, 116.0, 118.0, 117.0], "value": 115.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 114.0, 112.0, 160.0, 113.0, 98.0, 126.0, 143.0, 138.0, 144.0], "value": 129.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 203.0, 234.0, 287.0, 273.0, 197.0, 200.0, 199.0, 192.0, 196.0], "value": 218.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 62.0, 78.0, 109.0, 68.0, 59.0, 59.0, 68.0, 64.0, 60.0], "value": 71.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 103.0, 116.0, 102.0, 69.0, 73.0, 82.0, 70.0, 71.0, 82.0], "value": 88.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 88.0, 86.0, 105.0, 92.0, 119.0, 85.0, 104.0, 108.0], "value": 96.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 98.0, 154.0, 95.0, 96.0, 108.0, 97.0, 96.0, 119.0], "value": 105.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 96.0, 130.0, 89.0, 143.0, 89.0, 80.0, 142.0, 146.0, 97.0], "value": 111.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 68.0, 96.0, 92.0, 79.0, 61.0, 63.0, 62.0, 62.0, 62.0], "value": 69.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 105.0, 103.0, 100.0, 80.0, 71.0, 71.0, 69.0, 70.0, 74.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 108.0, 113.0, 106.0, 89.0, 87.0, 90.0, 87.0, 84.0, 98.0], "value": 96.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 151.0, 147.0, 163.0, 142.0, 145.0, 160.0, 146.0, 201.0, 195.0], "value": 160.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 175.0, 174.0, 172.0, 196.0, 236.0, 200.0, 175.0, 172.0, 248.0], "value": 192.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 67.0, 67.0, 68.0, 69.0, 67.0, 68.0, 67.0, 67.0], "value": 67.8, "unit": "score"}]}]} 11:22:11 INFO - Return code: 0 11:22:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:22:11 ERROR - # TBPL SUCCESS # 11:22:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:22:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:22:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:22:11 INFO - 2017-01-14 11:22:11.302 screenresolution[1658:10618] starting screenresolution argv=screenresolution get 11:22:11 INFO - 2017-01-14 11:22:11.305 screenresolution[1658:10618] Display 0: 1600x1200x32@60 11:22:11 INFO - 2017-01-14 11:22:11.311 screenresolution[1659:10621] starting screenresolution argv=screenresolution list 11:22:11 INFO - Available Modes on Display 0 11:22:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:22:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:22:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:22:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:22:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:22:11 INFO - Intel Iris: 11:22:11 INFO - Chipset Model: Intel Iris 11:22:11 INFO - Type: GPU 11:22:11 INFO - Bus: Built-In 11:22:11 INFO - VRAM (Dynamic, Max): 1536 MB 11:22:11 INFO - Vendor: Intel (0x8086) 11:22:11 INFO - Device ID: 0x0a2e 11:22:11 INFO - Revision ID: 0x0009 11:22:11 INFO - Displays: 11:22:11 INFO - Display: 11:22:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:22:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:22:11 INFO - Display Serial Number: 1600x1200 60 11:22:11 INFO - Main Display: Yes 11:22:11 INFO - Mirror: Off 11:22:11 INFO - Online: Yes 11:22:11 INFO - Rotation: Supported 11:22:11 INFO - Return code: 0 11:22:11 INFO - Running post-action listener: _resource_record_post_action 11:22:11 INFO - [mozharness: 2017-01-14 19:22:11.551629Z] Finished run-tests step (success) 11:22:11 INFO - Running post-run listener: _resource_record_post_run 11:22:11 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 38599168; Write bytes: 552686592; Read time: 242; Write time: 1703 11:22:11 INFO - TinderboxPrint: CPU usage
54.4% 11:22:11 INFO - TinderboxPrint: I/O read bytes / time
38,599,168 / 242 11:22:11 INFO - TinderboxPrint: I/O write bytes / time
552,686,592 / 1,703 11:22:11 INFO - TinderboxPrint: CPU idle
2,187.2 (45.6%) 11:22:11 INFO - TinderboxPrint: CPU system
962.8 (20.1%) 11:22:11 INFO - TinderboxPrint: CPU user
1,647.8 (34.3%) 11:22:11 INFO - TinderboxPrint: Swap in / out
290,365,440 / 0 11:22:11 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 241381888; Write bytes: 233672704; Read time: 17767; Write time: 506 11:22:11 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 36637184; Write bytes: 299414528; Read time: 226; Write time: 1149 11:22:12 INFO - Running post-run listener: _upload_blobber_files 11:22:12 INFO - Blob upload gear active. 11:22:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:22:12 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 11:22:12 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'] 11:22:12 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 11:22:12 INFO - (blobuploader) - INFO - Open directory for files ... 11:22:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:22:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:22:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:22:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:22:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:22:13 INFO - (blobuploader) - INFO - Done attempting. 11:22:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:22:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:22:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:22:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:22:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:22:14 INFO - (blobuploader) - INFO - Done attempting. 11:22:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:22:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:22:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:22:15 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:22:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:22:15 INFO - (blobuploader) - INFO - Done attempting. 11:22:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:22:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:22:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:22:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:22:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:22:18 INFO - (blobuploader) - INFO - Done attempting. 11:22:18 INFO - (blobuploader) - INFO - Iteration through files over. 11:22:18 INFO - Return code: 0 11:22:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:22:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:22:18 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/161ed947ad6b7959c55b2667ae2bc984412d376d8901634b73bf464cde301e2229800313303981dcca55f494f1d4658f45092f38a50adcc5b8c5d3257dabb229", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d1bc5944de0bb982d7a9a06184dba0f3d2959ff4795e30f57b86b8ea027427b73b2e8daaad5850fe379549125e2e8c92b6a4176323d9e365117f69b647917920", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6d8cbdc600884ca7879e547e2c9ff55cf6e652862424419009104c1c22bbcea226ae72dd7acb2078558f70f9f237de4f9546cbef6471659d848b8b3ea2e63e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cfb4553a2b8be0edab94f4dcf142a8c9b90e644a89edbb29caad16cf1dd1d588784a98bff02745b3f916bf4b229c98c0b3ec42a98dd8361a87e8c4af664456fa"} 11:22:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:22:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:22:18 INFO - Contents: 11:22:18 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/161ed947ad6b7959c55b2667ae2bc984412d376d8901634b73bf464cde301e2229800313303981dcca55f494f1d4658f45092f38a50adcc5b8c5d3257dabb229", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d1bc5944de0bb982d7a9a06184dba0f3d2959ff4795e30f57b86b8ea027427b73b2e8daaad5850fe379549125e2e8c92b6a4176323d9e365117f69b647917920", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6d8cbdc600884ca7879e547e2c9ff55cf6e652862424419009104c1c22bbcea226ae72dd7acb2078558f70f9f237de4f9546cbef6471659d848b8b3ea2e63e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cfb4553a2b8be0edab94f4dcf142a8c9b90e644a89edbb29caad16cf1dd1d588784a98bff02745b3f916bf4b229c98c0b3ec42a98dd8361a87e8c4af664456fa"} 11:22:18 INFO - Running post-run listener: copy_logs_to_upload_dir 11:22:18 INFO - Copying logs to upload dir... 11:22:18 INFO - mkdir: /builds/slave/test/build/upload/logs 11:22:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.555317 ========= master_lag: 2.55 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-01-14 11:22:20.972713) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2017-01-14 11:22:20.979840) ========= 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.7EebYWXfGg/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.yQbYWeEOSN/Listeners TMPDIR=/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/161ed947ad6b7959c55b2667ae2bc984412d376d8901634b73bf464cde301e2229800313303981dcca55f494f1d4658f45092f38a50adcc5b8c5d3257dabb229", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d1bc5944de0bb982d7a9a06184dba0f3d2959ff4795e30f57b86b8ea027427b73b2e8daaad5850fe379549125e2e8c92b6a4176323d9e365117f69b647917920", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6d8cbdc600884ca7879e547e2c9ff55cf6e652862424419009104c1c22bbcea226ae72dd7acb2078558f70f9f237de4f9546cbef6471659d848b8b3ea2e63e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cfb4553a2b8be0edab94f4dcf142a8c9b90e644a89edbb29caad16cf1dd1d588784a98bff02745b3f916bf4b229c98c0b3ec42a98dd8361a87e8c4af664456fa"} build_url:https://queue.taskcluster.net/v1/task/IOPa4sRRToGbahjHImyaBw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010922 build_url: 'https://queue.taskcluster.net/v1/task/IOPa4sRRToGbahjHImyaBw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/161ed947ad6b7959c55b2667ae2bc984412d376d8901634b73bf464cde301e2229800313303981dcca55f494f1d4658f45092f38a50adcc5b8c5d3257dabb229", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d1bc5944de0bb982d7a9a06184dba0f3d2959ff4795e30f57b86b8ea027427b73b2e8daaad5850fe379549125e2e8c92b6a4176323d9e365117f69b647917920", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6d8cbdc600884ca7879e547e2c9ff55cf6e652862424419009104c1c22bbcea226ae72dd7acb2078558f70f9f237de4f9546cbef6471659d848b8b3ea2e63e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cfb4553a2b8be0edab94f4dcf142a8c9b90e644a89edbb29caad16cf1dd1d588784a98bff02745b3f916bf4b229c98c0b3ec42a98dd8361a87e8c4af664456fa"}' ========= master_lag: 1.59 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2017-01-14 11:22:22.580231) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-14 11:22:22.580626) ========= 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.7EebYWXfGg/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.yQbYWeEOSN/Listeners TMPDIR=/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005304 ========= master_lag: 0.68 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-14 11:22:23.262271) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-14 11:22:23.262575) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-14 11:22:23.263748) ========= ========= Total master_lag: 4.89 =========