builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0367 starttime: 1484858877.41 results: success (0) buildid: 20170119071129 builduid: c70f3fdf1f924acab3275675a44e0caf revision: a3978751f45108ff1ae002ecebdc0fa23fc52b84 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-19 12:47:57.414598) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-19 12:47:57.415005) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-19 12:47:57.415307) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-19 12:47:57.466161) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 12:47:57.466407) ========= 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.ucF2zlRaiE/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.hV69cLB9B1/Listeners TMPDIR=/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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-19 12:47:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.9M=0.001s 2017-01-19 12:47:57 (18.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.173230 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 12:47:57.706294) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 12:47:57.706564) ========= 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.ucF2zlRaiE/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.hV69cLB9B1/Listeners TMPDIR=/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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.024176 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 12:47:57.755306) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-19 12:47:57.755602) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a3978751f45108ff1ae002ecebdc0fa23fc52b84 --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 a3978751f45108ff1ae002ecebdc0fa23fc52b84 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ucF2zlRaiE/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.hV69cLB9B1/Listeners TMPDIR=/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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-19 12:47:57,869 truncating revision to first 12 chars 2017-01-19 12:47:57,869 Setting DEBUG logging. 2017-01-19 12:47:57,869 attempt 1/10 2017-01-19 12:47:57,869 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a3978751f451?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-19 12:47:59,522 unpacking tar archive at: mozilla-central-a3978751f451/testing/mozharness/ program finished with exit code 0 elapsedTime=1.927982 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-19 12:47:59.708283) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-19 12:47:59.708598) ========= script_repo_revision: a3978751f45108ff1ae002ecebdc0fa23fc52b84 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-19 12:47:59.709032) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-19 12:47:59.709330) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-19 12:47:59.729736) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-01-19 12:47:59.730448) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.ucF2zlRaiE/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.hV69cLB9B1/Listeners TMPDIR=/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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 12:47:59 INFO - MultiFileLogger online at 20170119 12:47:59 in /builds/slave/test 12:47:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 12:47:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:47:59 INFO - {'append_to_log': False, 12:47:59 INFO - 'base_work_dir': '/builds/slave/test', 12:47:59 INFO - 'blob_upload_branch': 'Firefox', 12:47:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:47:59 INFO - 'branch': 'Firefox', 12:47:59 INFO - 'buildbot_json_path': 'buildprops.json', 12:47:59 INFO - 'config_files': ('talos/mac_config.py',), 12:47:59 INFO - 'default_actions': ('clobber', 12:47:59 INFO - 'read-buildbot-config', 12:47:59 INFO - 'download-and-extract', 12:47:59 INFO - 'populate-webroot', 12:47:59 INFO - 'create-virtualenv', 12:47:59 INFO - 'install', 12:47:59 INFO - 'run-tests'), 12:47:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:47:59 INFO - 'download_minidump_stackwalk': True, 12:47:59 INFO - 'download_symbols': 'ondemand', 12:47:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:47:59 INFO - 'tooltool.py': '/tools/tooltool.py', 12:47:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:47:59 INFO - '/tools/misc-python/virtualenv.py')}, 12:47:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:47:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:47:59 INFO - 'installer_path': 'installer.exe', 12:47:59 INFO - 'log_level': 'info', 12:47:59 INFO - 'log_name': 'talos', 12:47:59 INFO - 'log_to_console': True, 12:47:59 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:47:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:47:59 INFO - 'opt_config_files': (), 12:47:59 INFO - 'pip_index': False, 12:47:59 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:47:59 INFO - 'cmd': ('bash', 12:47:59 INFO - '-c', 12:47:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:47:59 INFO - 'enabled': True, 12:47:59 INFO - 'halt_on_failure': False, 12:47:59 INFO - 'name': 'check_screen_resolution'},), 12:47:59 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:47:59 INFO - 'cmd': ('bash', 12:47:59 INFO - '-c', 12:47:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:47:59 INFO - 'enabled': True, 12:47:59 INFO - 'halt_on_failure': False, 12:47:59 INFO - 'name': 'check_screen_resolution'},), 12:47:59 INFO - 'run_cmd_checks_enabled': True, 12:47:59 INFO - 'sps_profile': False, 12:47:59 INFO - 'sps_profile_interval': 0, 12:47:59 INFO - 'suite': 'dromaeojs', 12:47:59 INFO - 'system_bits': '32', 12:47:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:47:59 INFO - 'title': 't-yosemite-r7-0367', 12:47:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:47:59 INFO - 'use_talos_json': True, 12:47:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:47:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:47:59 INFO - 'work_dir': 'build'} 12:47:59 INFO - [mozharness: 2017-01-19 20:47:59.952595Z] Running clobber step. 12:47:59 INFO - Running pre-action listener: _resource_record_pre_action 12:47:59 INFO - Running main action method: clobber 12:47:59 INFO - rmtree: /builds/slave/test/build 12:47:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:48:02 INFO - Running post-action listener: _resource_record_post_action 12:48:02 INFO - [mozharness: 2017-01-19 20:48:02.197754Z] Finished clobber step (success) 12:48:02 INFO - [mozharness: 2017-01-19 20:48:02.197912Z] Running read-buildbot-config step. 12:48:02 INFO - Running pre-action listener: _resource_record_pre_action 12:48:02 INFO - Running main action method: read_buildbot_config 12:48:02 INFO - Using buildbot properties: 12:48:02 INFO - { 12:48:02 INFO - "project": "", 12:48:02 INFO - "product": "firefox", 12:48:02 INFO - "script_repo_revision": "production", 12:48:02 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 12:48:02 INFO - "repository": "", 12:48:02 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 12:48:02 INFO - "buildid": "20170119071129", 12:48:02 INFO - "pgo_build": "False", 12:48:02 INFO - "basedir": "/builds/slave/test", 12:48:02 INFO - "buildnumber": 121, 12:48:02 INFO - "slavename": "t-yosemite-r7-0367", 12:48:02 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 12:48:02 INFO - "platform": "yosemite_r7", 12:48:02 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 12:48:02 INFO - "branch": "mozilla-central", 12:48:02 INFO - "repo_path": "mozilla-central", 12:48:02 INFO - "revision": "a3978751f45108ff1ae002ecebdc0fa23fc52b84", 12:48:02 INFO - "stage_platform": "macosx64", 12:48:02 INFO - "builduid": "c70f3fdf1f924acab3275675a44e0caf", 12:48:02 INFO - "slavebuilddir": "test" 12:48:02 INFO - } 12:48:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 12:48:02 INFO - Running post-action listener: _resource_record_post_action 12:48:02 INFO - [mozharness: 2017-01-19 20:48:02.201257Z] Finished read-buildbot-config step (success) 12:48:02 INFO - [mozharness: 2017-01-19 20:48:02.201381Z] Running download-and-extract step. 12:48:02 INFO - Running pre-action listener: _resource_record_pre_action 12:48:02 INFO - Running main action method: download_and_extract 12:48:02 INFO - mkdir: /builds/slave/test/build/tests 12:48:02 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')]} 12:48:02 INFO - trying https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 12:48:02 INFO - Downloading https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/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 12:48:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/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 12:48:03 INFO - Downloaded 1199 bytes. 12:48:03 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 12:48:03 INFO - Using the following test package requirements: 12:48:03 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 12:48:03 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:48:03 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 12:48:03 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:48:03 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 12:48:03 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:48:03 INFO - u'jsshell-mac.zip'], 12:48:03 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:48:03 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 12:48:03 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 12:48:03 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:48:03 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 12:48:03 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:48:03 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 12:48:03 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:48:03 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 12:48:03 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:48:03 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 12:48:03 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:48:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 12:48:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:48:03 INFO - Fetch https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 12:48:05 INFO - Expected file size: 16340629 12:48:05 INFO - Obtained file size: 16340629 12:48:11 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 12:48:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 12:48:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:48:11 INFO - Fetch https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 12:48:13 INFO - Expected file size: 16340629 12:48:13 INFO - Obtained file size: 16340629 12:48:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 12:48:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 12:48:19 INFO - Fetch https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 12:48:22 INFO - Expected file size: 14403463 12:48:22 INFO - Obtained file size: 14403463 12:48:22 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')]} 12:48:22 INFO - trying https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 12:48:22 INFO - Downloading https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 12:48:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/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 12:48:25 INFO - Downloaded 69915509 bytes. 12:48:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 12:48:25 INFO - mkdir: /builds/slave/test/properties 12:48:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:48:25 INFO - Writing to file /builds/slave/test/properties/build_url 12:48:25 INFO - Contents: 12:48:25 INFO - build_url:https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 12:48:26 INFO - Running post-action listener: _resource_record_post_action 12:48:26 INFO - Running post-action listener: set_extra_try_arguments 12:48:26 INFO - [mozharness: 2017-01-19 20:48:26.050772Z] Finished download-and-extract step (success) 12:48:26 INFO - [mozharness: 2017-01-19 20:48:26.050914Z] Running populate-webroot step. 12:48:26 INFO - Running pre-action listener: _resource_record_pre_action 12:48:26 INFO - Running main action method: populate_webroot 12:48:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:48:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:48:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:48:26 INFO - '--tppagecycles', 12:48:26 INFO - '7'], 12:48:26 INFO - 'tests': ['tsvgm']}}, 12:48:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:48:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:48:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:48:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:48:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:48:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:48:26 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 12:48:26 INFO - 'talos_options': ['--disable-e10s'], 12:48:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:48:26 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:48:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:48:26 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 12:48:26 INFO - 'talos_options': ['--disable-e10s'], 12:48:26 INFO - 'tests': ['damp', 'tps']}, 12:48:26 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:48:26 INFO - 'tests': ['damp', 'tps']}, 12:48:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:48:26 INFO - 'tests': ['dromaeo_dom']}, 12:48:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:48:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:48:26 INFO - 'tests': ['basic_compositor_video']}, 12:48:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:48:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:48:26 INFO - 'tests': ['a11yr', 12:48:26 INFO - 'ts_paint', 12:48:26 INFO - 'tpaint', 12:48:26 INFO - 'sessionrestore', 12:48:26 INFO - 'sessionrestore_no_auto_restore', 12:48:26 INFO - 'tabpaint']}, 12:48:26 INFO - 'other-e10s': {'tests': ['a11yr', 12:48:26 INFO - 'ts_paint', 12:48:26 INFO - 'tpaint', 12:48:26 INFO - 'sessionrestore', 12:48:26 INFO - 'sessionrestore_no_auto_restore', 12:48:26 INFO - 'tabpaint']}, 12:48:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:48:26 INFO - 'ts_paint', 12:48:26 INFO - 'tpaint', 12:48:26 INFO - 'sessionrestore', 12:48:26 INFO - 'sessionrestore_no_auto_restore', 12:48:26 INFO - 'tabpaint']}, 12:48:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:48:26 INFO - 'ts_paint', 12:48:26 INFO - 'tpaint', 12:48:26 INFO - 'sessionrestore', 12:48:26 INFO - 'sessionrestore_no_auto_restore', 12:48:26 INFO - 'tabpaint']}, 12:48:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:48:26 INFO - 'tests': ['a11yr', 12:48:26 INFO - 'ts_paint', 12:48:26 INFO - 'tpaint', 12:48:26 INFO - 'sessionrestore', 12:48:26 INFO - 'sessionrestore_no_auto_restore', 12:48:26 INFO - 'tabpaint']}, 12:48:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:48:26 INFO - 'tests': ['a11yr', 12:48:26 INFO - 'ts_paint', 12:48:26 INFO - 'tpaint', 12:48:26 INFO - 'sessionrestore', 12:48:26 INFO - 'sessionrestore_no_auto_restore', 12:48:26 INFO - 'tabpaint']}, 12:48:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:48:26 INFO - 'tests': ['tsvgx', 12:48:26 INFO - 'tsvgr_opacity', 12:48:26 INFO - 'tart', 12:48:26 INFO - 'tscrollx', 12:48:26 INFO - 'cart', 12:48:26 INFO - 'tsvg_static']}, 12:48:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:48:26 INFO - 'tsvgr_opacity', 12:48:26 INFO - 'tart', 12:48:26 INFO - 'tscrollx', 12:48:26 INFO - 'cart', 12:48:26 INFO - 'tsvg_static']}, 12:48:26 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 12:48:26 INFO - 'talos_options': ['--disable-e10s'], 12:48:26 INFO - 'tests': ['tp5o']}, 12:48:26 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:48:26 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 12:48:26 INFO - 'talos_options': ['--disable-e10s', 12:48:26 INFO - '--xperf_path', 12:48:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:48:26 INFO - 'tests': ['tp5n']}, 12:48:26 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:48:26 INFO - 'talos_options': ['--xperf_path', 12:48:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:48:26 INFO - 'tests': ['tp5n']}}, 12:48:26 INFO - 'talos.zip': {'path': '', 12:48:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:48:26 INFO - Running post-action listener: _resource_record_post_action 12:48:26 INFO - [mozharness: 2017-01-19 20:48:26.069557Z] Finished populate-webroot step (success) 12:48:26 INFO - [mozharness: 2017-01-19 20:48:26.069690Z] Running create-virtualenv step. 12:48:26 INFO - Running pre-action listener: _resource_record_pre_action 12:48:26 INFO - Running main action method: create_virtualenv 12:48:26 INFO - Creating virtualenv /builds/slave/test/build/venv 12:48:26 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 12:48:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:48:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:48:26 INFO - Using real prefix '/tools/python27' 12:48:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:48:26 INFO - Installing distribute.............................................................................................................................................................................................done. 12:48:29 INFO - Installing pip.................done. 12:48:29 INFO - Return code: 0 12:48:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:48:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:48:29 INFO - Reading from file tmpfile_stdout 12:48:29 INFO - Output received: 12:48:29 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) 12:48:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:48:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:30 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')]} 12:48:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:30 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 0x10bdefb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdf2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8820cf0be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bbcdd30>, '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 0x10baf4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bbc2be8>, '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.ucF2zlRaiE/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.hV69cLB9B1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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 12:48:30 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 12:48:30 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 12:48:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ucF2zlRaiE/Render', 12:48:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:48:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:48:30 INFO - 'HOME': '/Users/cltbld', 12:48:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:48:30 INFO - 'LOGNAME': 'cltbld', 12:48:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:30 INFO - 'MOZ_NO_REMOTE': '1', 12:48:30 INFO - 'NO_EM_RESTART': '1', 12:48:30 INFO - 'PAGER': '/bin/cat', 12:48:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:48:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:30 INFO - 'PWD': '/builds/slave/test', 12:48:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:48:30 INFO - 'SHELL': '/bin/bash', 12:48:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hV69cLB9B1/Listeners', 12:48:30 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 12:48:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:48:30 INFO - 'USER': 'cltbld', 12:48:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:48:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:48:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:30 INFO - 'XPC_FLAGS': '0x0', 12:48:30 INFO - 'XPC_SERVICE_NAME': '0', 12:48:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:48:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:30 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 12:48:30 INFO - Cleaning up... 12:48:30 INFO - Return code: 0 12:48:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:48:30 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')]} 12:48:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:30 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')]} 12:48:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:30 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 0x10bdefb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdf2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8820cf0be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bbcdd30>, '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 0x10baf4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bbc2be8>, '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.ucF2zlRaiE/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.hV69cLB9B1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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 12:48:30 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 12:48:30 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 12:48:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ucF2zlRaiE/Render', 12:48:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:48:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:48:30 INFO - 'HOME': '/Users/cltbld', 12:48:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:48:30 INFO - 'LOGNAME': 'cltbld', 12:48:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:30 INFO - 'MOZ_NO_REMOTE': '1', 12:48:30 INFO - 'NO_EM_RESTART': '1', 12:48:30 INFO - 'PAGER': '/bin/cat', 12:48:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:48:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:30 INFO - 'PWD': '/builds/slave/test', 12:48:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:48:30 INFO - 'SHELL': '/bin/bash', 12:48:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hV69cLB9B1/Listeners', 12:48:30 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 12:48:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:48:30 INFO - 'USER': 'cltbld', 12:48:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:48:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:48:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:30 INFO - 'XPC_FLAGS': '0x0', 12:48:30 INFO - 'XPC_SERVICE_NAME': '0', 12:48:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:48:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:30 INFO - Downloading/unpacking psutil>=3.1.1 12:48:30 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 12:48:30 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 12:48:30 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 12:48:30 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 12:48:30 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 12:48:30 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 12:48:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:48:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:48:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:48:34 INFO - Installing collected packages: psutil 12:48:34 INFO - Running setup.py install for psutil 12:48:34 INFO - building 'psutil._psutil_osx' extension 12:48:34 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 12:48:35 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 12:48:35 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 12:48:35 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 12:48:35 INFO - building 'psutil._psutil_posix' extension 12:48:35 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 12:48:35 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:48:35 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:48:35 INFO - ^ 12:48:35 INFO - 1 warning generated. 12:48:35 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 12:48:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:48:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:48:35 INFO - Successfully installed psutil 12:48:35 INFO - Cleaning up... 12:48:35 INFO - Return code: 0 12:48:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:48: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')]} 12:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48: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')]} 12:48:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:35 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 0x10bdefb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdf2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8820cf0be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bbcdd30>, '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 0x10baf4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bbc2be8>, '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.ucF2zlRaiE/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.hV69cLB9B1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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 12:48:35 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 12:48:35 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 12:48:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ucF2zlRaiE/Render', 12:48:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:48:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:48:35 INFO - 'HOME': '/Users/cltbld', 12:48:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:48:35 INFO - 'LOGNAME': 'cltbld', 12:48:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:35 INFO - 'MOZ_NO_REMOTE': '1', 12:48:35 INFO - 'NO_EM_RESTART': '1', 12:48:35 INFO - 'PAGER': '/bin/cat', 12:48:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:48:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:35 INFO - 'PWD': '/builds/slave/test', 12:48:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:48:35 INFO - 'SHELL': '/bin/bash', 12:48:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hV69cLB9B1/Listeners', 12:48:35 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 12:48:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:48:35 INFO - 'USER': 'cltbld', 12:48:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:48:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:48:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:35 INFO - 'XPC_FLAGS': '0x0', 12:48:35 INFO - 'XPC_SERVICE_NAME': '0', 12:48:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:48:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:48:36 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 12:48:36 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 12:48:36 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 12:48:36 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 12:48:36 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 12:48:36 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 12:48:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:48:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:48:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:48:38 INFO - Installing collected packages: mozsystemmonitor 12:48:38 INFO - Running setup.py install for mozsystemmonitor 12:48:38 INFO - Successfully installed mozsystemmonitor 12:48:38 INFO - Cleaning up... 12:48:38 INFO - Return code: 0 12:48:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:48:38 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')]} 12:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:38 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')]} 12:48:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:38 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 0x10bdefb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdf2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8820cf0be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bbcdd30>, '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 0x10baf4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bbc2be8>, '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.ucF2zlRaiE/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.hV69cLB9B1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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 12:48:38 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 12:48:38 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 12:48:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ucF2zlRaiE/Render', 12:48:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:48:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:48:38 INFO - 'HOME': '/Users/cltbld', 12:48:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:48:38 INFO - 'LOGNAME': 'cltbld', 12:48:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:38 INFO - 'MOZ_NO_REMOTE': '1', 12:48:38 INFO - 'NO_EM_RESTART': '1', 12:48:38 INFO - 'PAGER': '/bin/cat', 12:48:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:48:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:38 INFO - 'PWD': '/builds/slave/test', 12:48:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:48:38 INFO - 'SHELL': '/bin/bash', 12:48:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hV69cLB9B1/Listeners', 12:48:38 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 12:48:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:48:38 INFO - 'USER': 'cltbld', 12:48:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:48:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:48:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:38 INFO - 'XPC_FLAGS': '0x0', 12:48:38 INFO - 'XPC_SERVICE_NAME': '0', 12:48:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:48:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:39 INFO - Downloading/unpacking jsonschema==2.5.1 12:48:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:48:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:48:41 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 12:48:41 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 12:48:41 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 12:48:41 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 12:48:41 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 12:48:41 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 12:48:42 INFO - Downloading functools32-3.2.3-2.tar.gz 12:48:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:48:42 INFO - warning: no files found matching '*.txt' 12:48:42 INFO - no previously-included directories found matching 'build' 12:48:42 INFO - no previously-included directories found matching 'dist' 12:48:42 INFO - no previously-included directories found matching '.git*' 12:48:42 INFO - Installing collected packages: jsonschema, functools32 12:48:42 INFO - Running setup.py install for functools32 12:48:42 INFO - warning: no files found matching '*.txt' 12:48:42 INFO - no previously-included directories found matching 'build' 12:48:42 INFO - no previously-included directories found matching 'dist' 12:48:42 INFO - no previously-included directories found matching '.git*' 12:48:42 INFO - Successfully installed jsonschema functools32 12:48:42 INFO - Cleaning up... 12:48:42 INFO - Return code: 0 12:48:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:48: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')]} 12:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48: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')]} 12:48:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48: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', '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 0x10bdefb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdf2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8820cf0be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bbcdd30>, '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 0x10baf4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bbc2be8>, '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.ucF2zlRaiE/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.hV69cLB9B1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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 12:48: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:48: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 functools32==3.2.3-2 12:48:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ucF2zlRaiE/Render', 12:48:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:48:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:48:42 INFO - 'HOME': '/Users/cltbld', 12:48:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:48:42 INFO - 'LOGNAME': 'cltbld', 12:48:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:42 INFO - 'MOZ_NO_REMOTE': '1', 12:48:42 INFO - 'NO_EM_RESTART': '1', 12:48:42 INFO - 'PAGER': '/bin/cat', 12:48:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:48:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:42 INFO - 'PWD': '/builds/slave/test', 12:48:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:48:42 INFO - 'SHELL': '/bin/bash', 12:48:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hV69cLB9B1/Listeners', 12:48:42 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 12:48:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:48:42 INFO - 'USER': 'cltbld', 12:48:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:48:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:48:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:42 INFO - 'XPC_FLAGS': '0x0', 12:48:42 INFO - 'XPC_SERVICE_NAME': '0', 12:48:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:48:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:48:42 INFO - Cleaning up... 12:48:42 INFO - Return code: 0 12:48:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:48: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')]} 12:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48: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')]} 12:48:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48: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', '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 0x10bdefb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdf2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8820cf0be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bbcdd30>, '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 0x10baf4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bbc2be8>, '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.ucF2zlRaiE/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.hV69cLB9B1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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 12:48: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:48: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 blobuploader==1.2.4 12:48:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ucF2zlRaiE/Render', 12:48:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:48:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:48:42 INFO - 'HOME': '/Users/cltbld', 12:48:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:48:42 INFO - 'LOGNAME': 'cltbld', 12:48:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:42 INFO - 'MOZ_NO_REMOTE': '1', 12:48:42 INFO - 'NO_EM_RESTART': '1', 12:48:42 INFO - 'PAGER': '/bin/cat', 12:48:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:48:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:42 INFO - 'PWD': '/builds/slave/test', 12:48:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:48:42 INFO - 'SHELL': '/bin/bash', 12:48:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hV69cLB9B1/Listeners', 12:48:42 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 12:48:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:48:42 INFO - 'USER': 'cltbld', 12:48:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:48:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:48:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:42 INFO - 'XPC_FLAGS': '0x0', 12:48:42 INFO - 'XPC_SERVICE_NAME': '0', 12:48:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:48:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:43 INFO - Downloading/unpacking blobuploader==1.2.4 12:48:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:45 INFO - Downloading blobuploader-1.2.4.tar.gz 12:48:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:48:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:48:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:48:46 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 12:48:46 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 12:48:46 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 12:48:46 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 12:48:46 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 12:48:46 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 12:48:46 INFO - Downloading docopt-0.6.1.tar.gz 12:48:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:48:47 INFO - Installing collected packages: blobuploader, requests, docopt 12:48:47 INFO - Running setup.py install for blobuploader 12:48:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:48:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:48:47 INFO - Running setup.py install for requests 12:48:47 INFO - Running setup.py install for docopt 12:48:47 INFO - Successfully installed blobuploader requests docopt 12:48:47 INFO - Cleaning up... 12:48:47 INFO - Return code: 0 12:48:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:48: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')]} 12:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48: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')]} 12:48:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:47 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 0x10bdefb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdf2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8820cf0be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bbcdd30>, '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 0x10baf4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bbc2be8>, '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.ucF2zlRaiE/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.hV69cLB9B1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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 12:48:47 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 12:48:47 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 12:48:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ucF2zlRaiE/Render', 12:48:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:48:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:48:47 INFO - 'HOME': '/Users/cltbld', 12:48:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:48:47 INFO - 'LOGNAME': 'cltbld', 12:48:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:47 INFO - 'MOZ_NO_REMOTE': '1', 12:48:47 INFO - 'NO_EM_RESTART': '1', 12:48:47 INFO - 'PAGER': '/bin/cat', 12:48:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:48:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:47 INFO - 'PWD': '/builds/slave/test', 12:48:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:48:47 INFO - 'SHELL': '/bin/bash', 12:48:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hV69cLB9B1/Listeners', 12:48:47 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 12:48:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:48:47 INFO - 'USER': 'cltbld', 12:48:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:48:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:48:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:47 INFO - 'XPC_FLAGS': '0x0', 12:48:47 INFO - 'XPC_SERVICE_NAME': '0', 12:48:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:48:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:48:48 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-KNFRMp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:48:48 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-sfibO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:48:48 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-opdQul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:48:48 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-zMfwnQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:48:48 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-3349Wc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:48:48 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-XvCaMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:48:48 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-8oPzy4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:48:48 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-tppuUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:48:49 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-WMQenY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:48:49 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-kNDOxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:48:49 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-jrm35v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:48:49 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-4IguA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:48:49 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-NtVnei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:48:49 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-SLQMlq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:48:49 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-ZS5M8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:48:49 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-36A4H9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:48:49 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-SWcHmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:48:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:48:49 INFO - Running setup.py install for manifestparser 12:48:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:48:50 INFO - Running setup.py install for mozcrash 12:48:50 INFO - Running setup.py install for mozdebug 12:48:50 INFO - Running setup.py install for mozdevice 12:48:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:48:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:48:50 INFO - Running setup.py install for mozfile 12:48:50 INFO - Running setup.py install for mozhttpd 12:48:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:48:50 INFO - Running setup.py install for mozinfo 12:48:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:48:50 INFO - Running setup.py install for mozInstall 12:48:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:48:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:48:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:48:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:48:51 INFO - Running setup.py install for mozleak 12:48:51 INFO - Running setup.py install for mozlog 12:48:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:48:51 INFO - Running setup.py install for moznetwork 12:48:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:48:51 INFO - Running setup.py install for mozprocess 12:48:51 INFO - Running setup.py install for mozprofile 12:48:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:48:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:48:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:48:51 INFO - Running setup.py install for mozrunner 12:48:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:48:52 INFO - Running setup.py install for mozscreenshot 12:48:52 INFO - Running setup.py install for moztest 12:48:52 INFO - Running setup.py install for mozversion 12:48:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:48:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:48:52 INFO - Cleaning up... 12:48:52 INFO - Return code: 0 12:48:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:48:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:52 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 0x10bdefb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdf2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8820cf0be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bbcdd30>, '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 0x10baf4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bbc2be8>, '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.ucF2zlRaiE/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.hV69cLB9B1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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 12:48:52 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 12:48:52 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 12:48:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ucF2zlRaiE/Render', 12:48:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:48:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:48:52 INFO - 'HOME': '/Users/cltbld', 12:48:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:48:52 INFO - 'LOGNAME': 'cltbld', 12:48:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:52 INFO - 'MOZ_NO_REMOTE': '1', 12:48:52 INFO - 'NO_EM_RESTART': '1', 12:48:52 INFO - 'PAGER': '/bin/cat', 12:48:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:48:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:52 INFO - 'PWD': '/builds/slave/test', 12:48:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:48:52 INFO - 'SHELL': '/bin/bash', 12:48:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hV69cLB9B1/Listeners', 12:48:52 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 12:48:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:48:52 INFO - 'USER': 'cltbld', 12:48:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:48:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:48:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:52 INFO - 'XPC_FLAGS': '0x0', 12:48:52 INFO - 'XPC_SERVICE_NAME': '0', 12:48:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:48:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:48:52 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-6zObfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:48:52 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)) 12:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:48:52 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-dmORPX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:48:53 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)) 12:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:48:53 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-wCTqfl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:48:53 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)) 12:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:48:53 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-64pssc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:48:53 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)) 12:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:48:53 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-nulHG7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:48:53 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)) 12:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:48:53 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-mnojx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:48:53 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)) 12:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:48:53 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-Uo4X8X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:48:53 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)) 12:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:48:53 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-JvNyNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:48:53 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)) 12:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:48:53 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-ScG68a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:48:53 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)) 12:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:48:53 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-Jw4_8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:48:53 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)) 12:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:48:53 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-rHwQCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:48:53 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)) 12:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:48:53 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-WfB32g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:48:54 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)) 12:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:48:54 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-MRO5tZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:48:54 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)) 12:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:48:54 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-ucXsQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:48:54 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)) 12:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:48:54 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-V6Oyh1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:48:54 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)) 12:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:48:54 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-AF5y8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:48:54 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)) 12:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:48:54 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-2ACuEZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:48:54 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)) 12:48:54 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)) 12:48:54 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)) 12:48:54 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)) 12:48:54 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)) 12:48:54 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)) 12:48:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:48: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 12:48: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 12:48: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 12:48: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 12:48: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 12:48: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 12:48:57 INFO - Downloading blessings-1.6.tar.gz 12:48:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:48:57 INFO - Installing collected packages: blessings 12:48:57 INFO - Running setup.py install for blessings 12:48:57 INFO - Successfully installed blessings 12:48:57 INFO - Cleaning up... 12:48:57 INFO - Return code: 0 12:48:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:48:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:48:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:48:57 INFO - Reading from file tmpfile_stdout 12:48:57 INFO - Current package versions: 12:48:57 INFO - blessings == 1.6 12:48:57 INFO - blobuploader == 1.2.4 12:48:57 INFO - docopt == 0.6.1 12:48:57 INFO - functools32 == 3.2.3-2 12:48:57 INFO - jsonschema == 2.5.1 12:48:57 INFO - manifestparser == 1.1 12:48:57 INFO - mozInstall == 1.12 12:48:57 INFO - mozcrash == 1.0 12:48:57 INFO - mozdebug == 0.1 12:48:57 INFO - mozdevice == 0.49 12:48:57 INFO - mozfile == 1.2 12:48:57 INFO - mozhttpd == 0.7 12:48:57 INFO - mozinfo == 0.9 12:48:57 INFO - mozleak == 0.1 12:48:57 INFO - mozlog == 3.4 12:48:57 INFO - moznetwork == 0.27 12:48:57 INFO - mozprocess == 0.24 12:48:57 INFO - mozprofile == 0.28 12:48:57 INFO - mozrunner == 6.13 12:48:57 INFO - mozscreenshot == 0.1 12:48:57 INFO - mozsystemmonitor == 0.3 12:48:57 INFO - moztest == 0.8 12:48:57 INFO - mozversion == 1.4 12:48:57 INFO - psutil == 3.1.1 12:48:57 INFO - requests == 1.2.3 12:48:57 INFO - wsgiref == 0.1.2 12:48:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:48:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:57 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 0x10bdefb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdf2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8820cf0be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bbcdd30>, '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 0x10baf4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bbc2be8>, '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.ucF2zlRaiE/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.hV69cLB9B1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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 12:48:57 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 12:48:57 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 12:48:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ucF2zlRaiE/Render', 12:48:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:48:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:48:57 INFO - 'HOME': '/Users/cltbld', 12:48:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:48:57 INFO - 'LOGNAME': 'cltbld', 12:48:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:57 INFO - 'MOZ_NO_REMOTE': '1', 12:48:57 INFO - 'NO_EM_RESTART': '1', 12:48:57 INFO - 'PAGER': '/bin/cat', 12:48:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:48:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:57 INFO - 'PWD': '/builds/slave/test', 12:48:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:48:57 INFO - 'SHELL': '/bin/bash', 12:48:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hV69cLB9B1/Listeners', 12:48:57 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 12:48:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:48:57 INFO - 'USER': 'cltbld', 12:48:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:48:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:48:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:57 INFO - 'XPC_FLAGS': '0x0', 12:48:57 INFO - 'XPC_SERVICE_NAME': '0', 12:48:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:48:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:58 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)) 12:48:58 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)) 12:48:58 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)) 12:48:58 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)) 12:48:58 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)) 12:48:58 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)) 12:48:58 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)) 12:48:58 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)) 12:48:58 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)) 12:48:58 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)) 12:48:58 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)) 12:48:58 INFO - Cleaning up... 12:48:58 INFO - Return code: 0 12:48:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:48:58 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')]} 12:48:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:58 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')]} 12:48:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:58 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 0x10bdefb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdf2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8820cf0be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bbcdd30>, '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 0x10baf4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bbc2be8>, '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.ucF2zlRaiE/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.hV69cLB9B1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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 12:48:58 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 12:48:58 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 12:48:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ucF2zlRaiE/Render', 12:48:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:48:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:48:58 INFO - 'HOME': '/Users/cltbld', 12:48:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:48:58 INFO - 'LOGNAME': 'cltbld', 12:48:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:58 INFO - 'MOZ_NO_REMOTE': '1', 12:48:58 INFO - 'NO_EM_RESTART': '1', 12:48:58 INFO - 'PAGER': '/bin/cat', 12:48:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:48:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:58 INFO - 'PWD': '/builds/slave/test', 12:48:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:48:58 INFO - 'SHELL': '/bin/bash', 12:48:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hV69cLB9B1/Listeners', 12:48:58 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 12:48:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:48:58 INFO - 'USER': 'cltbld', 12:48:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:48:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:48:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:58 INFO - 'XPC_FLAGS': '0x0', 12:48:58 INFO - 'XPC_SERVICE_NAME': '0', 12:48:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:48:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:48:58 INFO - Cleaning up... 12:48:58 INFO - Return code: 0 12:48:58 INFO - Running post-action listener: _resource_record_post_action 12:48:58 INFO - Running post-action listener: _start_resource_monitoring 12:48:58 INFO - Starting resource monitoring. 12:48:58 INFO - [mozharness: 2017-01-19 20:48:58.444235Z] Finished create-virtualenv step (success) 12:48:58 INFO - [mozharness: 2017-01-19 20:48:58.445194Z] Running install step. 12:48:58 INFO - Running pre-action listener: _resource_record_pre_action 12:48:58 INFO - Running main action method: install 12:48:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:48:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:48:58 INFO - Reading from file tmpfile_stdout 12:48:58 INFO - Detecting whether we're running mozinstall >=1.0... 12:48:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:48:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:48:58 INFO - Reading from file tmpfile_stdout 12:48:58 INFO - Output received: 12:48:58 INFO - Usage: mozinstall [options] installer 12:48:58 INFO - Options: 12:48:58 INFO - -h, --help show this help message and exit 12:48:58 INFO - -d DEST, --destination=DEST 12:48:58 INFO - Directory to install application into. [default: 12:48:58 INFO - "/builds/slave/test"] 12:48:58 INFO - --app=APP Application being installed. [default: firefox] 12:48:58 INFO - mkdir: /builds/slave/test/build/application 12:48:58 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'] 12:48:58 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 12:49:20 INFO - Reading from file tmpfile_stdout 12:49:20 INFO - Output received: 12:49:20 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:49:20 INFO - Running post-action listener: _resource_record_post_action 12:49:20 INFO - [mozharness: 2017-01-19 20:49:20.656182Z] Finished install step (success) 12:49:20 INFO - [mozharness: 2017-01-19 20:49:20.656333Z] Running run-tests step. 12:49:20 INFO - Running pre-action listener: _resource_record_pre_action 12:49:20 INFO - Running main action method: run_tests 12:49:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:49:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:49:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:49:20 INFO - 2017-01-19 12:49:20.670 screenresolution[1638:8448] starting screenresolution argv=screenresolution get 12:49:20 INFO - 2017-01-19 12:49:20.673 screenresolution[1638:8448] Display 0: 1600x1200x32@60 12:49:20 INFO - 2017-01-19 12:49:20.679 screenresolution[1639:8450] starting screenresolution argv=screenresolution list 12:49:20 INFO - Available Modes on Display 0 12:49:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:49:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:49:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:49:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:49:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:49:20 INFO - Intel Iris: 12:49:20 INFO - Chipset Model: Intel Iris 12:49:20 INFO - Type: GPU 12:49:20 INFO - Bus: Built-In 12:49:20 INFO - VRAM (Dynamic, Max): 1536 MB 12:49:20 INFO - Vendor: Intel (0x8086) 12:49:20 INFO - Device ID: 0x0a2e 12:49:20 INFO - Revision ID: 0x0009 12:49:20 INFO - Displays: 12:49:20 INFO - Display: 12:49:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:49:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:49:20 INFO - Display Serial Number: 1600x1200 60 12:49:20 INFO - Main Display: Yes 12:49:20 INFO - Mirror: Off 12:49:20 INFO - Online: Yes 12:49:20 INFO - Rotation: Supported 12:49:20 INFO - Return code: 0 12:49:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:49:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:49:20 INFO - Python 2.7.3 12:49:20 INFO - Return code: 0 12:49:20 INFO - grabbing minidump binary from tooltool 12:49:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:49:20 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 0x10bbcdd30>, '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 0x10baf4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bbc2be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:49:20 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 12:49:20 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 12:49:20 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 12:49:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:49:21 INFO - Return code: 0 12:49:21 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:49:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:49:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:49:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:49:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:49:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0367', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 12:49:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0367 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 12:49:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ucF2zlRaiE/Render', 12:49:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:49:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:49:21 INFO - 'HOME': '/Users/cltbld', 12:49:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:49:21 INFO - 'LOGNAME': 'cltbld', 12:49:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:49:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:49:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:49:21 INFO - 'MOZ_NO_REMOTE': '1', 12:49:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:49:21 INFO - 'NO_EM_RESTART': '1', 12:49:21 INFO - 'PAGER': '/bin/cat', 12:49:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:49:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:49:21 INFO - 'PWD': '/builds/slave/test', 12:49:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:49:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:49:21 INFO - 'SHELL': '/bin/bash', 12:49:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hV69cLB9B1/Listeners', 12:49:21 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 12:49:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:49:21 INFO - 'USER': 'cltbld', 12:49:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:49:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:49:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:49:21 INFO - 'XPC_FLAGS': '0x0', 12:49:21 INFO - 'XPC_SERVICE_NAME': '0', 12:49:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:49:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0367', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 12:49:21 INFO - mozversion application_buildid: 20170119071129 12:49:21 INFO - mozversion application_changeset: a3978751f45108ff1ae002ecebdc0fa23fc52b84 12:49:21 INFO - mozversion application_display_name: Nightly 12:49:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:49:21 INFO - mozversion application_name: Firefox 12:49:21 INFO - mozversion application_remotingname: firefox 12:49:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:49:21 INFO - mozversion application_vendor: Mozilla 12:49:21 INFO - mozversion application_version: 53.0a1 12:49:21 INFO - mozversion platform_buildid: 20170119071129 12:49:21 INFO - mozversion platform_changeset: a3978751f45108ff1ae002ecebdc0fa23fc52b84 12:49:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:49:21 INFO - mozversion platform_version: 53.0a1 12:49:21 INFO - using testdate: 1484858961 12:49:21 INFO - actual date: 1484858961 12:49:21 INFO - starting webserver on 'localhost:49248' 12:49:21 INFO - SUITE-START | Running 2 tests 12:49:21 INFO - TEST-START | dromaeo_css 12:49:21 INFO - operating with platform_type : mac_ 12:49:21 INFO - Initialising browser for dromaeo_css test... 12:49:21 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/tmphiLxR1/profile http://localhost:49248/getInfo.html) 12:49:23 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 12:49:23 INFO - PROCESS | 1649 | colorDepth:24 12:49:23 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 12:49:23 INFO - PROCESS | 1649 | __metrics 12:49:23 INFO - PROCESS | 1649 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:49:23 INFO - PROCESS | 1649 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:49:24 INFO - TEST-INFO | 1649: exit 0 12:49:24 INFO - Browser initialized. 12:49:24 INFO - Running cycle 1/1 for dromaeo_css test... 12:49:24 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/tmphiLxR1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:49:36 INFO - PROCESS | 1652 | RSS: Main: 235319296 12:49:36 INFO - PROCESS | 1652 | 12:52:40 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49248/tests/dromaeo/cssquery-ext.html) 12:52:41 INFO - PROCESS | 1652 | RSS: Main: 354328576 12:52:41 INFO - PROCESS | 1652 | 12:54:26 INFO - PROCESS | 1652 | ************************* 12:54:26 INFO - PROCESS | 1652 | A coding exception was thrown and uncaught in a Task. 12:54:26 INFO - PROCESS | 1652 | 12:54:26 ERROR - PROCESS | 1652 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:54:26 INFO - PROCESS | 1652 | Full stack: 12:54:26 INFO - PROCESS | 1652 | ************************* 12:55:44 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-ext.html (next: http://localhost:49248/tests/dromaeo/cssquery-jquery.html) 12:55:45 INFO - PROCESS | 1652 | RSS: Main: 367550464 12:55:45 INFO - PROCESS | 1652 | 12:58:47 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49248/tests/dromaeo/cssquery-mootools.html) 12:58:47 INFO - PROCESS | 1652 | RSS: Main: 331264000 12:58:47 INFO - PROCESS | 1652 | 13:01:50 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49248/tests/dromaeo/cssquery-prototype.html) 13:01:51 INFO - PROCESS | 1652 | RSS: Main: 341778432 13:01:51 INFO - PROCESS | 1652 | 13:04:54 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49248/tests/dromaeo/cssquery-yui.html) 13:04:55 INFO - PROCESS | 1652 | RSS: Main: 325312512 13:04:55 INFO - PROCESS | 1652 | 13:07:58 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-yui.html (next: http://localhost:49248/tests/dromaeo/cssquery-dojo.html) 13:07:58 INFO - PROCESS | 1652 | RSS: Main: 480428032 13:07:58 INFO - PROCESS | 1652 | 13:07:58 INFO - PROCESS | 1652 | __start_tp_report 13:07:58 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 13:07:58 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 13:07:58 INFO - PROCESS | 1652 | |i|pagename|runs| 13:07:58 INFO - PROCESS | 1652 | |0;dojo.html;3275.8034517928913;3285.86856525739;3287.704106630404;3296.373688999089;3347;5495.422980587041;5537.501624853762;5596.216529685842;5614.9438505614935;5619.971900140498;5524.364698059724;5585.916211256825;5588.888222235563;5591.7483713232905;5592.664440133595;5043.546080852722;5073.797048118071;5078.669886457368;5131.640785145041;5171.818986335479;5142.151544995071;5169.353830771153;5183.067047931371;5229.503197196279;5231.895362092756;5215.087359712035;5242.79028838846;5269;5270.657407268534;5299.735013249341;4401.339799030171;5221.190715439113;5236.581073514109;5240.52835244826;5259.658122222043;302.4378414075288;5058.0895438821;5124.205748109049;5157.71632560209;5176.301199338079;4713.693609915379;5607.887842243133;5646.040173170571;5658.575606829463;5695.800646977336;6227.346128656471;6233.532485063593;6238.812835614939;6245.906311405332;6252.843678908018;6127.5404344674325;6221.471174950135;6240.875182496325;6272.18461599989;6282.560220784547;5659.179418984224;5696.430356964353;5720.11338242573;5727.656340619576;5748;6250.843728906813;6262.843428914222;6273.12176295319;6282.465990390868;6284.874302513924;6057.878842423127;6104.20645316106;6107.236595425572;6110.144579758838;6118;5479.698616576047;5815;6042.788502402394;6124;6170.629762214281;6133.509319254449;6153.29237137726;6157.199564056644;6166.691665416801;6173.475254603409;6170;6174.536909731788;6191.783287584913;6201.069839524108;6202.379762023852;4625.542953969489;4813.061453016699;4852.539008794159;4875.341828853059;4888.2178851383605;4333.43665323506;4339;4364.10535840152;4406.669499787528;4465.709728867613;5462.579729270339;5616.887662246732;5674.205611214434;5730.083186690193;5757.453041961007;5496.532794712414;6139.338817383189;6142.069075791497;6150.415710507495;6152.230971128609;5669.31968163823;5713.657180569096;5760.711964401847;5767.134929760486;5807.88384232313;5286.497782710637;5339.225812257201;5359.866003349869;5377.7311134443125;5378.650387724863;6200.255969283715;6220.595661282002;6267.122602835698;6275;6319.842003949938;6136.028952951454;6146.877062458636;6147.708981114016;6150.04674275488;6152.354002829638;6282.748690052346;6292.811215663537;6294.622322660472;6298.370162983665;6361.459275961595;5983.461488465885;6072.787452439144;6104.603200791934;6105.297890742621;6164.660943648142;6105.399096011559;6127.036821038878;6143.327652471189;6146.262448506208;6164.47601953839;5213.843584692465;5263.868403289948;5932.762689492372;6076.787312444043;6102.0541816018585;5944.821655350346;6018;6040.577159598786;6043.516518678407;6044.879102418015;5727.541796656341;5783.392743762012;5822.650640961556;5827.329857066322;5859.296884373903;6051.273847138372;6056.636601803906;6067.605605635619;6069.605475644069;6104.969475152596;5825.475707186373;5859.5019423347785;5861.824145275648;5868.94131058701;5878.441548052928 13:07:58 INFO - PROCESS | 1652 | |1;ext.html;467.5091154287999;491.9606431485482;502.2466300549175;507.28472853276867;508.60583048137664;30970.53544196836;39605.60394396055;42143.578564214346;42158;42298;42746.572534274645;43057.35413968793;43130.13739725204;43162.92092697684;43240.13519729603;9121.40710853794;9292.535373231345;9320.161185493303;9344.018878017812;9352.111549402829;8339.95830020852;8555.10171432;9282.396644218137;11047.72380690481;11334.886651133507;11219.66341009771;11270.492827822727;11272.436378181099;11284.943575282112;11313.377764222965;11160.888391116107;11219.439028048564;11225.60710375137;11231.831522527169;11250.3812290324;8301.96225471816;8513.957430212871;10903.781924361469;11136.944315278453;11204.21570490066;41033.79483102595;41434;41473.79263103665;41515.792421038;41591.792041039604;4029.8388064477385;4045.4336392905016;4060.6548443382053;4093.608173221089;4102.589741025903;29776;30360.84819575888;31118.844405777825;31195;31569.21076973094;2720.7076638596704;3141.4031334046686;3149.7480201583817;3176.237702951298;3283.835808209604;451588;465166.0225096626;474471;478052;485631;60188;60491.39508604858;60529.09206361908;60612.393876060676;60633.69683151556;62934.68532657399;63279.367206328265;63291;63357;63458.0481292781;15340.539783806504;15768.921155394379;15802;15819.52541423759;15822.841771582367;12261.877381226073;12336;12361.505539778487;12362.44369003397;12363.196392234477;13755.17468951846;14139.43442262298;14141.929290353482;14477.710445791236;14484.493042743454;5680.289963754531;6535.150430444107;6685.331466853276;7140.357367836919;7261.636918154071;865.8398196333699;868.8740132680726;876.8947726272888;914.6067191107887;918.1140199707314;29584.408311834075;29740.40519189604;29978.70021299803;30353.24116897095;30396.54405183924;992.2905122837062;1074.7957888001254;1111.2054880760134;1123.152020224725;1191.362620997762;15034.69930601382;15452.5364239073;15499.457518986781;15626.45307414235;15894.364225431085;570872.1456392691;625560;629962;630395;630991;43732.34401483917;53644.463555364724;53750.7312463443;53811.73094134583;53994.19008714794;1416.4121889415983;1425.3942074618246;1448.377197804954;1450.108183467181;1455.1592235821695;27336.453270934868;28275.648331434386;28617.28456788597;28642;28645.856770716015;45055.0988980212;45272.32091518696;45527.54472455233;45537.77231113823;45777.77111114423;532222.6944326268;533687;535039;535986;537295;19815.702764458834;23709.288721338387;24725.629115562922;25013.374665633506;25672.871635641703;35190.768323109594;38759.03102422349;41606.37590436207;43525.56474435215;45412.54587454216;35771.64228357683;35863.64136358603;36050;36780;36942.630573694994;35484.82257588695;36002.45996310005;36211.27577448384;36357.45463817992;36944.89165324937;34485.48271775875;35078.824605876805;35442.468362975094;35729.64270357367;35797;30047.699523005365;31114.533282000335;31837.20406989844;32109.03672889817;32196.517052243766;22718.65922011138;23441.648375274726;23528.882355588114;23569.292921212393;23598.29205123849 13:07:58 INFO - PROCESS | 1652 | |2;jquery.html;342.5871824451536;382.9195868867538;392.69762283042047;405.24826446940904;414.2894935186157;18884.62230755384;21648.567028659458;21687.24094656687;21814.345569632897;21951.780482195194;21397.57204855902;21819;22033.33899982999;22246.777532224714;22381;5288.233206185101;5775.797847075332;5838.2994040715175;5865.120231965218;5871.412858714137;4153.0863210093885;4248.426462427564;4351.325544540601;5711.942880571182;5746.913796293059;4352.020795321059;4386.451693538308;6430.549861509696;6433.195850518685;6437.83905402364;6157.507399408037;6321.146645202884;6412.935870641304;6421.325760795096;6423.839404014913;5633.8591535211535;5635.464630860061;5645.294338207724;5645.633033852828;5648.237487939158;25011.62482562745;25062.12282570101;25399.873000635063;25633.871830640914;25648.61527077095;2733.5079685656574;2788.553831386989;2790.748832605055;2817.112609527992;2844.132539575429;15329.386824527006;15685.764713529306;15770.921145394313;16127.919360403122;16516.50450486475;1768.8142745011717;1809;1811.5199472139893;1815.636872625467;1818.5817262029675;132363;135546.32226838902;135658.6434135656;136406;137720.6227937718;11184.608538701106;11472.54109835614;11550.653480395602;11590.13074019435;11784.116191285688;14611.78082328766;14629.341679624229;14640.487582934758;14642.780358294634;14669;8132.471389359673;8336.374771892133;8581.442206256697;8600.655973761104;8646.783830404165;8460.492370457792;8479.152084791594;8511.787205319793;8660;8688.174623410765;6591.91233446476;6620.4041636252;6971.058907047585;7109.431245500347;7132.393746531603;1895.8293753562245;1930.3147382678947;1944.8541359398102;1948.5518330783998;1950.570874407628;1050.5850189175233;1065.211743309945;1069.7218723132041;1075.3279200499687;1115.0577761791274;20841.89579052095;23120.4219894504;23142.42143946415;23212.071517139462;23259.06963721466;1078.7734575739182;1081.859358283418;1114.3703807348822;1121.1647322744607;1139.9886001140048;10708.449295314174;11165.218434709492;11960.15940229134;12114.81827772584;12149.392530373623;709519;709890;723232;725043;738716;125508;129158.35420822835;156521;168139;168930;442.90256143648344;462.7131178669179;464.9767511624473;465.12788521522145;467.9938133014115;10459.633912813015;11451.14116441287;11587.130965177814;11849.822252666045;11945.402729863647;45972;56682.433175669365;58196.709016454646;59537.7023114899;60016.39983600108;87247;87285;88793.55603221942;89093;90834.54582727309;8420.831583368421;8509;8652.524111173694;8709.303255739398;8870.86693699582;12726.427310771223;12967;13467.932660336635;13495.865041349854;13902.652433689238;11340.489677964346;11436.19946603763;11766.941165294462;11828.17202795796;11982.820257696316;11203.88796112061;11334.773304534028;11591.536338546364;11622.535098595961;11654.242474239147;11094.223404361617;11235.55057797679;11551.133664974992;11639.301641901513;11852.170348075897;7935.2064793520185;8360.958195208985;8507.702230421906;8641.012567109725;8690.174433428814;9074.45553266806;11666.416679166177;11788.823167652663;11856.466459009538;11906.940465297617 13:07:58 INFO - PROCESS | 1652 | |3;mootools.html;1474.542891703572;1480.8445113263115;1485.331600779649;1500.2498750624682;1504.2102895979613;8119.066307374654;8491.023532293788;8503.2347088762;8519.275861551769;8525.445846020004;7405.666744996474;7655;7661.46369754116;8079.596020198996;8318.625661845217;2258.9661155082686;2309.226409152936;2312.1560630369877;2315.872627005514;2319.6752454656275;2308.2152068296778;2308.272894038381;2328.161861729776;2334.124703236286;2335.6963594732747;2274.056266649347;2280.5552917181158;2297.6094064009158;2299.379167624749;2301.3211102724654;2096.6330892093824;2120.2579097315893;2130.8508404411696;2133.4559687279643;2142.710734050914;1979.3369221310877;2012.2655230840785;2171.8489200723643;2330.8251881108986;2332.3586013846157;8426.410151289412;8454.87317690235;8475.788105297355;8475.915240847575;8488.872666910001;4978.128827455217;5154.742262886841;5158.432572417031;5159.277701121846;5166.276721259027;3177.189816596753;3304.653011433813;3468.1156305142026;3519.208178159919;3524.7356448266482;1157.7163594919214;1197.0543270816045;1198.6284251881857;1250.4623012104792;1260.0864373329264;9798.922118566952;10271.691849244535;10733.570657173703;10829.783404331947;10853;4405.251107311765;4587.632989360844;4668.3697700810635;4678.391809064799;4679.766011699469;9441.24470042395;9446.055394460498;9465;9477.526123693788;9486.146246837818;5198.4801519847715;5211.843644690665;5216.478352164829;5218.582513398995;5227.947720522822;3814.675752561008;4216.283231850532;4649.604783593365;4689.812407503729;4753.714777113315;3773.6226377362045;3791.3554695701796;3882.96117038826;3893.824777885002;3917.471141395932;1074.3500182389541;1106.8395082713123;1280.7566562353122;1286.1511402474323;1293.683047653331;688.7520492622651;859.8151397449578;906.1210625693067;915.3226612306845;942.5617088054088;5171.301874247004;5301.1783173608155;5551.611387202938;5632.690202038927;5708.57185711065;830.5009457928377;897.4839467306325;902.1835239108617;965.4400447740434;986.8766404199475;3422.691957723767;3680.8895733128047;3728.813559322023;3799.240151969562;3807;9635.470049147223;9961.302708810459;10005.04952029556;10041.949790251148;10054.648087317055;9961.302708810459;9961.750956226153;9978.251631127549;9980.80038399228;9980.950095249478;7312.926870731225;7693.884591731128;7744.7676569703;7883.132855385903;7892.881606775903;5461.481159289861;5571.498565128995;5617.297837770278;5646.576506761927;5776.42235776419;8750.343724220837;8897.199252067345;8976.102389760972;9127.726168214964;9139.908600914172;8950.86573701408;9118.17936385702;9372.625094996123;9440.905590944278;9465.621375144918;6526.347365263626;6749.797506074826;6751.93248067513;6982.092327997328;7231.819204519718;7610.885836712565;7888.723894663659;7914.802129946567;7990.800229994296;8010.599470026359;7015.6842942066705;7138.535995160298;7157.606331651601;7184.892226616709;7275.854482910207;6849.897251541331;7007.7196912122945;7008.5094043416475;7080.04419403374;7108.182559005573;5538.390777014606;6257.124002639725;6298.212723409574;6351.872962540816;6385.96807015962;4672.598220533759;4919.3604831371695;4939.901201975868;4993.425756038102;5050.3182070420025;4715.669903106749;4859.343988561499;4861.7326047066335;4937.23472861707;4946.208606622923 13:07:58 INFO - PROCESS | 1652 | |4;prototype.html;348.6304517211756;349.69751165242064;358.1368900948713;365.0963864435521;367.14272174472603;5167.767450464728;5171.276021357013;5234.790608375661;5243.303471052908;5251.396089449714;4137.317342638468;4286.228478873802;4539.276434139515;4592.701474404162;4969.602431805456;4012.7792971386634;4014.658754005913;4072.328065869143;4075.982388717589;4102.282100632392;3793.525809273841;3816.0313274194805;4017.718759686823;4047.797610119482;4074.6129117733767;3704.8332825022803;3898.9805050974846;4015.2571774221715;4027.7784721840285;4035.354343305072;3318.8340582970877;3550.9644903550893;3904.492415985904;3906.4921560196995;3940.2119576084897;3163.1775738308206;3369.107186595554;3385.4414021686393;3399.1814379307198;3401.9829900850586;4373.978130109361;4591.4260717410325;4790.712557246577;4999.675021123615;5010.774515146791;4199.7610704842145;4437.889052773674;4439.289713645801;4454.7995340209445;4498.672891497016;4438.0014496738295;5311.601629877736;5315.893682126336;5383.16560933056;5420.864478388072;3189.7607679423904;3680.7975561344115;3708.8516459341595;3743.887683369503;3768.3782175940937;5237.931017248204;5318.936212757425;5646.943530564683;5679.148127780824;5709.42905709434;3499.8625446729916;3635.2729454109285;3742.3450896093077;3753.981230093832;3780.4518344839844;3807.676347510437;3828.75113117652;3830.8276127573768;3831.272058308912;3835.7150354630953;3614.313280476701;3926.509186351706;4076.7553946763287;4096.3036283831225;4444.977655139336;4803.486901626046;5138.460461651547;5347.556159836822;5473.917891231635;5478.643888147258;1229.8193734015445;1237.870023647522;1242.912996090265;1243.5088140184575;1253.6865783554113;682.0757873082001;801.9398545109024;827.606886728799;832.3216578488513;844.6494704697482;4062.471878655815;4364.825406983685;4784.401949756211;4786.8085276588545;4798.2082956311815;4649.396338050635;5193.454687257859;5246.898151388251;5288.055667950479;5360.981413531416;4259.381435054659;4600.2869555218995;4666.1834179019215;4755.690880092783;4765.1660959331975;2388.9283321500384;2553.080890879319;2786.5959435882087;2788.5817127431046;2791.4696207720467;4802.543758342952;5132.615053870974;5276.709780962007;5353.491418315254;5545.085060964896;4664.720116793003;4913.631477639191;5202.271681964528;5285.436563266812;5485.177223416519;4316.568343165658;5293.285406470154;5305.912287981032;5429.294191755047;5549.306336707992;4949.802007919643;5050.49495050492;5152.793888244578;5263.447338029452;5359.732013399236;4312.7627980461375;4605.930911036404;4820.373351464287;4867.641327484024;4942.802287908444;4887.437944636412;4925;5222.843314700565;5577.414371490935;5582.33012038558;3121.814729689181;3336.9833150834093;3541.3625547401716;3570.892873213808;3580.0846547097176;4500.504944456173;4819.481778301789;4913.213885778258;5015.398152221611;5265.473452654704;4759.357486739246;5098.668586541863;5107.799667078308;5110.850058736754;5155.845324640267;4294;4984.4517103117905;5035.571976382049;5073.6513900825275;5083.237514372874;3948;4522.63818894481;4753.6452111148155;4893.947801222755;4936.950630493649;4592.908141837212;5264.947350526446;5267.313670028237;5287.488442989549;5387.892242155057;5057.721825299644;5247.344081989751;5310.522053015247;5323.653962492425;5323.707196104251 13:07:58 INFO - PROCESS | 1652 | |5;yui.html;724.4096061709706;769.507515190278;783.5377127494777;837.8910741603592;843.8185790055137;14496.420143194273;15359.462418815316;15397;15445.691086178284;15450.690986180283;14142.363593638285;14308.141511509317;14309.284535773195;14311.499097531589;14325.641858953531;692.407991167552;708.9113860767404;709.652270387509;863.8013256950906;875.0199776250608;883.9513826739527;898.5821592959272;899.4603238057146;900.5902314446944;901.5041727050129;951.9904800951971;952.7284723853703;954.6944977607169;958.8657587937695;961.9182369498566;722.1839321566648;735.1141874041767;906.9773255668595;948.9703671516413;953.408886490377;695.2803848017278;698.0297386632585;700.5061431690646;700.908881845362;704.0530486495707;14770;15097.849021509754;15125.848741512555;15144.772828407582;15147.54557363281;13752;13792;13802.723945521133;13935.372908219155;13953.651158721113;12784.680382990407;12881.291528965903;12976.026797990095;13168.86831131686;13284.53504127351;4439.511653718088;4482.932756008662;4511.554830754547;4572.3827283317;4707.482176960531;105597;108631;111255.44372278168;111701.44149279202;113368;10858.511366988505;10984.133588939523;11019.614313498989;11221.990020898158;11257.887421125848;21796.564068718853;22299.777002230094;22306.888465557568;22338.55322893533;22414;6346.682665866688;7708.344790692854;7749.380049596019;7801.765947021599;7828.138904720477;4223.788810559459;4236.2586547354085;4301.526832048472;4311.288637374798;4400.867973960786;3417.743669224818;3525.682688557991;3531.4702794581017;3551.236484155919;3819.3698039823116;716.7634680555404;726.4551586310267;734.3170851108521;742.1539445032668;743.3087228877196;613.411125319698;665.8069159943659;691.3190507350256;695.5305169010898;700.3661686174021;10229.130523905551;10417.895821041693;10444.21668374875;10588.470576471145;10648.467576621139;666.2271764752863;711.7259854955879;717.9712811487482;723.5803234124301;732.5934106570904;4908.141075311806;5087.87280317995;5093.847184584469;5109.4379618241965;5120.7951681933055;82727;101832.47251291237;104283;104890;106030.8064572584;64691.67654161699;89935.55032224928;90936;91336;92748.53625731828;77715;78176.60911695405;79412.60293698494;79662;80701.19298807054;9760.707178784647;9762.951185244028;9788.951055244679;9805.754856128653;9818;44554.77722611366;45000.32499512575;45331;49439.50560494349;49849.252261215384;64037;64773.67613161904;68357.3164268351;68787.65606172137;69668;11762.470878786045;12159.45282462309;13130.606081817561;13229.47082116743;13512;11975.940120299343;14868.85131148718;15015.390725846402;15104;15135.394584216509;13799;13805.51680691171;13905.791413128609;14026.22855742944;14166.929165354108;13865.376058077612;13969.58091257264;14172.645683857985;14204.78692819588;14437.566872993826;13392.799108013582;13758.587242382744;13781.104228225133;14125.364358604093;14218.928905355408;10818.729531761768;11289.784080886422;11508.314665043268;11587.304761714324;11627.360495172847;11012.779744404907;11228.775424491629;11255.887441125484;11271.943640281746;11276.830847537458 13:07:58 INFO - PROCESS | 1652 | __end_tp_report 13:07:58 INFO - PROCESS | 1652 | __start_cc_report 13:07:58 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,1252 13:07:58 INFO - PROCESS | 1652 | __end_cc_report 13:07:58 INFO - PROCESS | 1652 | __startTimestamp1484860078794__endTimestamp 13:07:58 INFO - PROCESS | 1652 | 13:07:58 INFO - PROCESS | 1652 | ------- Summary: start ------- 13:07:58 INFO - PROCESS | 1652 | Number of tests: 6 13:07:58 INFO - PROCESS | 1652 | 13:07:58 INFO - PROCESS | 1652 | [#0] dojo.html Cycles:165 Average:5632.43 Median:5822.65 stddev:768.97 (13.2%) stddev-sans-first:748.77 13:07:58 INFO - PROCESS | 1652 | Values: 3275.8 3285.9 3287.7 3296.4 3347.0 5495.4 5537.5 5596.2 5614.9 5620.0 5524.4 5585.9 5588.9 5591.7 5592.7 5043.5 5073.8 5078.7 5131.6 5171.8 5142.2 5169.4 5183.1 5229.5 5231.9 5215.1 5242.8 5269.0 5270.7 5299.7 4401.3 5221.2 5236.6 5240.5 5259.7 302.4 5058.1 5124.2 5157.7 5176.3 4713.7 5607.9 5646.0 5658.6 5695.8 6227.3 6233.5 6238.8 6245.9 6252.8 6127.5 6221.5 6240.9 6272.2 6282.6 5659.2 5696.4 5720.1 5727.7 5748.0 6250.8 6262.8 6273.1 6282.5 6284.9 6057.9 6104.2 6107.2 6110.1 6118.0 5479.7 5815.0 6042.8 6124.0 6170.6 6133.5 6153.3 6157.2 6166.7 6173.5 6170.0 6174.5 6191.8 6201.1 6202.4 4625.5 4813.1 4852.5 4875.3 4888.2 4333.4 4339.0 4364.1 4406.7 4465.7 5462.6 5616.9 5674.2 5730.1 5757.5 5496.5 6139.3 6142.1 6150.4 6152.2 5669.3 5713.7 5760.7 5767.1 5807.9 5286.5 5339.2 5359.9 5377.7 5378.7 6200.3 6220.6 6267.1 6275.0 6319.8 6136.0 6146.9 6147.7 6150.0 6152.4 6282.7 6292.8 6294.6 6298.4 6361.5 5983.5 6072.8 6104.6 6105.3 6164.7 6105.4 6127.0 6143.3 6146.3 6164.5 5213.8 5263.9 5932.8 6076.8 6102.1 5944.8 6018.0 6040.6 6043.5 6044.9 5727.5 5783.4 5822.7 5827.3 5859.3 6051.3 6056.6 6067.6 6069.6 6105.0 5825.5 5859.5 5861.8 5868.9 5878.4 13:07:58 INFO - PROCESS | 1652 | 13:07:58 INFO - PROCESS | 1652 | [#1] ext.html Cycles:180 Average:66991.37 Median:36130.64 stddev:145483.68 (402.7%) stddev-sans-first:145806.06 13:07:58 INFO - PROCESS | 1652 | Values: 467.5 492.0 502.2 507.3 508.6 30970.5 39605.6 42143.6 42158.0 42298.0 42746.6 43057.4 43130.1 43162.9 43240.1 9121.4 9292.5 9320.2 9344.0 9352.1 8340.0 8555.1 9282.4 11047.7 11334.9 11219.7 11270.5 11272.4 11284.9 11313.4 11160.9 11219.4 11225.6 11231.8 11250.4 8302.0 8514.0 10903.8 11136.9 11204.2 41033.8 41434.0 41473.8 41515.8 41591.8 4029.8 4045.4 4060.7 4093.6 4102.6 29776.0 30360.8 31118.8 31195.0 31569.2 2720.7 3141.4 3149.7 3176.2 3283.8 451588.0 465166.0 474471.0 478052.0 485631.0 60188.0 60491.4 60529.1 60612.4 60633.7 62934.7 63279.4 63291.0 63357.0 63458.0 15340.5 15768.9 15802.0 15819.5 15822.8 12261.9 12336.0 12361.5 12362.4 12363.2 13755.2 14139.4 14141.9 14477.7 14484.5 5680.3 6535.2 6685.3 7140.4 7261.6 865.8 868.9 876.9 914.6 918.1 29584.4 29740.4 29978.7 30353.2 30396.5 992.3 1074.8 1111.2 1123.2 1191.4 15034.7 15452.5 15499.5 15626.5 15894.4 570872.1 625560.0 629962.0 630395.0 630991.0 43732.3 53644.5 53750.7 53811.7 53994.2 1416.4 1425.4 1448.4 1450.1 1455.2 27336.5 28275.6 28617.3 28642.0 28645.9 45055.1 45272.3 45527.5 45537.8 45777.8 532222.7 533687.0 535039.0 535986.0 537295.0 19815.7 23709.3 24725.6 25013.4 25672.9 35190.8 38759.0 41606.4 43525.6 45412.5 35771.6 35863.6 36050.0 36780.0 36942.6 35484.8 36002.5 36211.3 36357.5 36944.9 34485.5 35078.8 35442.5 35729.6 35797.0 30047.7 31114.5 31837.2 32109.0 32196.5 22718.7 23441.6 23528.9 23569.3 23598.3 13:07:58 INFO - PROCESS | 1652 | 13:07:58 INFO - PROCESS | 1652 | [#2] jquery.html Cycles:180 Average:40151.48 Median:23131.42 stddev:120365.19 (520.4%) stddev-sans-first:120665.73 13:07:58 INFO - PROCESS | 1652 | Values: 342.6 382.9 392.7 405.2 414.3 18884.6 21648.6 21687.2 21814.3 21951.8 21397.6 21819.0 22033.3 22246.8 22381.0 5288.2 5775.8 5838.3 5865.1 5871.4 4153.1 4248.4 4351.3 5711.9 5746.9 4352.0 4386.5 6430.5 6433.2 6437.8 6157.5 6321.1 6412.9 6421.3 6423.8 5633.9 5635.5 5645.3 5645.6 5648.2 25011.6 25062.1 25399.9 25633.9 25648.6 2733.5 2788.6 2790.7 2817.1 2844.1 15329.4 15685.8 15770.9 16127.9 16516.5 1768.8 1809.0 1811.5 1815.6 1818.6 132363.0 135546.3 135658.6 136406.0 137720.6 11184.6 11472.5 11550.7 11590.1 11784.1 14611.8 14629.3 14640.5 14642.8 14669.0 8132.5 8336.4 8581.4 8600.7 8646.8 8460.5 8479.2 8511.8 8660.0 8688.2 6591.9 6620.4 6971.1 7109.4 7132.4 1895.8 1930.3 1944.9 1948.6 1950.6 1050.6 1065.2 1069.7 1075.3 1115.1 20841.9 23120.4 23142.4 23212.1 23259.1 1078.8 1081.9 1114.4 1121.2 1140.0 10708.4 11165.2 11960.2 12114.8 12149.4 709519.0 709890.0 723232.0 725043.0 738716.0 125508.0 129158.4 156521.0 168139.0 168930.0 442.9 462.7 465.0 465.1 468.0 10459.6 11451.1 11587.1 11849.8 11945.4 45972.0 56682.4 58196.7 59537.7 60016.4 87247.0 87285.0 88793.6 89093.0 90834.5 8420.8 8509.0 8652.5 8709.3 8870.9 12726.4 12967.0 13467.9 13495.9 13902.7 11340.5 11436.2 11766.9 11828.2 11982.8 11203.9 11334.8 11591.5 11622.5 11654.2 11094.2 11235.6 11551.1 11639.3 11852.2 7935.2 8361.0 8507.7 8641.0 8690.2 9074.5 11666.4 11788.8 11856.5 11906.9 13:07:58 INFO - PROCESS | 1652 | 13:07:58 INFO - PROCESS | 1652 | [#3] mootools.html Cycles:180 Average:5379.93 Median:5217.53 stddev:2940.82 (56.4%) stddev-sans-first:2934.42 13:07:58 INFO - PROCESS | 1652 | Values: 1474.5 1480.8 1485.3 1500.2 1504.2 8119.1 8491.0 8503.2 8519.3 8525.4 7405.7 7655.0 7661.5 8079.6 8318.6 2259.0 2309.2 2312.2 2315.9 2319.7 2308.2 2308.3 2328.2 2334.1 2335.7 2274.1 2280.6 2297.6 2299.4 2301.3 2096.6 2120.3 2130.9 2133.5 2142.7 1979.3 2012.3 2171.8 2330.8 2332.4 8426.4 8454.9 8475.8 8475.9 8488.9 4978.1 5154.7 5158.4 5159.3 5166.3 3177.2 3304.7 3468.1 3519.2 3524.7 1157.7 1197.1 1198.6 1250.5 1260.1 9798.9 10271.7 10733.6 10829.8 10853.0 4405.3 4587.6 4668.4 4678.4 4679.8 9441.2 9446.1 9465.0 9477.5 9486.1 5198.5 5211.8 5216.5 5218.6 5227.9 3814.7 4216.3 4649.6 4689.8 4753.7 3773.6 3791.4 3883.0 3893.8 3917.5 1074.4 1106.8 1280.8 1286.2 1293.7 688.8 859.8 906.1 915.3 942.6 5171.3 5301.2 5551.6 5632.7 5708.6 830.5 897.5 902.2 965.4 986.9 3422.7 3680.9 3728.8 3799.2 3807.0 9635.5 9961.3 10005.0 10041.9 10054.6 9961.3 9961.8 9978.3 9980.8 9981.0 7312.9 7693.9 7744.8 7883.1 7892.9 5461.5 5571.5 5617.3 5646.6 5776.4 8750.3 8897.2 8976.1 9127.7 9139.9 8950.9 9118.2 9372.6 9440.9 9465.6 6526.3 6749.8 6751.9 6982.1 7231.8 7610.9 7888.7 7914.8 7990.8 8010.6 7015.7 7138.5 7157.6 7184.9 7275.9 6849.9 7007.7 7008.5 7080.0 7108.2 5538.4 6257.1 6298.2 6351.9 6386.0 4672.6 4919.4 4939.9 4993.4 5050.3 4715.7 4859.3 4861.7 4937.2 4946.2 13:07:58 INFO - PROCESS | 1652 | 13:07:58 INFO - PROCESS | 1652 | [#4] prototype.html Cycles:180 Average:4229.90 Median:4665.45 stddev:1263.01 (27.1%) stddev-sans-first:1232.50 13:07:58 INFO - PROCESS | 1652 | Values: 348.6 349.7 358.1 365.1 367.1 5167.8 5171.3 5234.8 5243.3 5251.4 4137.3 4286.2 4539.3 4592.7 4969.6 4012.8 4014.7 4072.3 4076.0 4102.3 3793.5 3816.0 4017.7 4047.8 4074.6 3704.8 3899.0 4015.3 4027.8 4035.4 3318.8 3551.0 3904.5 3906.5 3940.2 3163.2 3369.1 3385.4 3399.2 3402.0 4374.0 4591.4 4790.7 4999.7 5010.8 4199.8 4437.9 4439.3 4454.8 4498.7 4438.0 5311.6 5315.9 5383.2 5420.9 3189.8 3680.8 3708.9 3743.9 3768.4 5237.9 5318.9 5646.9 5679.1 5709.4 3499.9 3635.3 3742.3 3754.0 3780.5 3807.7 3828.8 3830.8 3831.3 3835.7 3614.3 3926.5 4076.8 4096.3 4445.0 4803.5 5138.5 5347.6 5473.9 5478.6 1229.8 1237.9 1242.9 1243.5 1253.7 682.1 801.9 827.6 832.3 844.6 4062.5 4364.8 4784.4 4786.8 4798.2 4649.4 5193.5 5246.9 5288.1 5361.0 4259.4 4600.3 4666.2 4755.7 4765.2 2388.9 2553.1 2786.6 2788.6 2791.5 4802.5 5132.6 5276.7 5353.5 5545.1 4664.7 4913.6 5202.3 5285.4 5485.2 4316.6 5293.3 5305.9 5429.3 5549.3 4949.8 5050.5 5152.8 5263.4 5359.7 4312.8 4605.9 4820.4 4867.6 4942.8 4887.4 4925.0 5222.8 5577.4 5582.3 3121.8 3337.0 3541.4 3570.9 3580.1 4500.5 4819.5 4913.2 5015.4 5265.5 4759.4 5098.7 5107.8 5110.9 5155.8 4294.0 4984.5 5035.6 5073.7 5083.2 3948.0 4522.6 4753.6 4893.9 4937.0 4592.9 5264.9 5267.3 5287.5 5387.9 5057.7 5247.3 5310.5 5323.7 5323.7 13:07:58 INFO - PROCESS | 1652 | 13:07:58 INFO - PROCESS | 1652 | [#5] yui.html Cycles:180 Average:20494.25 Median:4268.89 stddev:29306.58 (686.5%) stddev-sans-first:29351.19 13:07:58 INFO - PROCESS | 1652 | Values: 724.4 769.5 783.5 837.9 843.8 14496.4 15359.5 15397.0 15445.7 15450.7 14142.4 14308.1 14309.3 14311.5 14325.6 692.4 708.9 709.7 863.8 875.0 884.0 898.6 899.5 900.6 901.5 952.0 952.7 954.7 958.9 961.9 722.2 735.1 907.0 949.0 953.4 695.3 698.0 700.5 700.9 704.1 14770.0 15097.8 15125.8 15144.8 15147.5 13752.0 13792.0 13802.7 13935.4 13953.7 12784.7 12881.3 12976.0 13168.9 13284.5 4439.5 4482.9 4511.6 4572.4 4707.5 105597.0 108631.0 111255.4 111701.4 113368.0 10858.5 10984.1 11019.6 11222.0 11257.9 21796.6 22299.8 22306.9 22338.6 22414.0 6346.7 7708.3 7749.4 7801.8 7828.1 4223.8 4236.3 4301.5 4311.3 4400.9 3417.7 3525.7 3531.5 3551.2 3819.4 716.8 726.5 734.3 742.2 743.3 613.4 665.8 691.3 695.5 700.4 10229.1 10417.9 10444.2 10588.5 10648.5 666.2 711.7 718.0 723.6 732.6 4908.1 5087.9 5093.8 5109.4 5120.8 82727.0 101832.5 104283.0 104890.0 106030.8 64691.7 89935.6 90936.0 91336.0 92748.5 77715.0 78176.6 79412.6 79662.0 80701.2 9760.7 9763.0 9789.0 9805.8 9818.0 44554.8 45000.3 45331.0 49439.5 49849.3 64037.0 64773.7 68357.3 68787.7 69668.0 11762.5 12159.5 13130.6 13229.5 13512.0 11975.9 14868.9 15015.4 15104.0 15135.4 13799.0 13805.5 13905.8 14026.2 14166.9 13865.4 13969.6 14172.6 14204.8 14437.6 13392.8 13758.6 13781.1 14125.4 14218.9 10818.7 11289.8 11508.3 11587.3 11627.4 11012.8 11228.8 11255.9 11271.9 11276.8 13:07:58 INFO - PROCESS | 1652 | -------- Summary: end -------- 13:07:58 INFO - PROCESS | 1652 | 13:07:59 INFO - TEST-INFO | 1652: exit 0 13:07:59 INFO - TEST-OK | dromaeo_css | took 1118213ms 13:07:59 INFO - TEST-START | kraken 13:07:59 INFO - operating with platform_type : mac_ 13:07:59 INFO - Initialising browser for kraken test... 13:07:59 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/tmptzcQxn/profile http://localhost:49248/getInfo.html) 13:08:01 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 13:08:01 INFO - PROCESS | 1658 | colorDepth:24 13:08:01 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 13:08:01 INFO - PROCESS | 1658 | __metrics 13:08:01 INFO - PROCESS | 1658 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:08:01 INFO - PROCESS | 1658 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:08:02 INFO - TEST-INFO | 1658: exit 0 13:08:02 INFO - Browser initialized. 13:08:02 INFO - Running cycle 1/1 for kraken test... 13:08:02 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/tmptzcQxn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:08:14 INFO - PROCESS | 1659 | RSS: Main: 235442176 13:08:14 INFO - PROCESS | 1659 | 13:08:17 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection) 13:08:18 INFO - PROCESS | 1659 | RSS: Main: 287272960 13:08:18 INFO - PROCESS | 1659 | 13:08:20 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-dft) 13:08:21 INFO - PROCESS | 1659 | RSS: Main: 286765056 13:08:21 INFO - PROCESS | 1659 | 13:08:24 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-fft) 13:08:25 INFO - PROCESS | 1659 | RSS: Main: 379805696 13:08:25 INFO - PROCESS | 1659 | 13:08:27 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator) 13:08:28 INFO - PROCESS | 1659 | RSS: Main: 283029504 13:08:28 INFO - PROCESS | 1659 | 13:08:30 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:08:30 INFO - PROCESS | 1659 | RSS: Main: 286769152 13:08:30 INFO - PROCESS | 1659 | 13:08:33 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom) 13:08:34 INFO - PROCESS | 1659 | RSS: Main: 330186752 13:08:34 INFO - PROCESS | 1659 | 13:08:37 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate) 13:08:37 INFO - PROCESS | 1659 | RSS: Main: 331874304 13:08:37 INFO - PROCESS | 1659 | 13:08:40 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial) 13:08:41 INFO - PROCESS | 1659 | RSS: Main: 328302592 13:08:41 INFO - PROCESS | 1659 | 13:08:42 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:08:43 INFO - PROCESS | 1659 | RSS: Main: 303484928 13:08:43 INFO - PROCESS | 1659 | 13:08:45 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:08:46 INFO - PROCESS | 1659 | RSS: Main: 305893376 13:08:46 INFO - PROCESS | 1659 | 13:08:48 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:08:48 INFO - PROCESS | 1659 | RSS: Main: 308998144 13:08:48 INFO - PROCESS | 1659 | 13:08:51 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:08:52 INFO - PROCESS | 1659 | RSS: Main: 326127616 13:08:52 INFO - PROCESS | 1659 | 13:08:55 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:08:56 INFO - PROCESS | 1659 | RSS: Main: 320204800 13:08:56 INFO - PROCESS | 1659 | 13:08:57 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49248/tests/kraken/driver.html?testName=ai-astar) 13:08:58 INFO - PROCESS | 1659 | RSS: Main: 364400640 13:08:58 INFO - PROCESS | 1659 | 13:08:58 INFO - PROCESS | 1659 | __start_tp_report 13:08:58 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 13:08:58 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 13:08:58 INFO - PROCESS | 1659 | |i|pagename|runs| 13:08:58 INFO - PROCESS | 1659 | |0;ai-astar;110;112;116;158;167;113;114;113;113;113 13:08:58 INFO - PROCESS | 1659 | |1;audio-beat-detection;143;110;108;146;114;110;108;109;130;109 13:08:58 INFO - PROCESS | 1659 | |2;audio-dft;185;184;181;188;183;183;181;182;181;184 13:08:58 INFO - PROCESS | 1659 | |3;audio-fft;79;58;59;86;62;77;82;80;85;58 13:08:58 INFO - PROCESS | 1659 | |4;audio-oscillator;89;71;86;70;68;70;82;69;69;83 13:08:58 INFO - PROCESS | 1659 | |5;imaging-gaussian-blur;90;87;90;87;89;86;89;86;89;86 13:08:58 INFO - PROCESS | 1659 | |6;imaging-darkroom;95;94;93;95;94;94;95;95;94;94 13:08:58 INFO - PROCESS | 1659 | |7;imaging-desaturate;84;88;87;84;86;85;87;100;133;140 13:08:58 INFO - PROCESS | 1659 | |8;json-parse-financial;55;54;53;55;54;56;55;55;54;56 13:08:58 INFO - PROCESS | 1659 | |9;json-stringify-tinderbox;64;72;76;72;72;66;71;71;70;70 13:08:58 INFO - PROCESS | 1659 | |10;stanford-crypto-aes;90;87;86;86;91;87;88;86;92;92 13:08:58 INFO - PROCESS | 1659 | |11;stanford-crypto-ccm;143;138;143;146;148;131;139;140;190;176 13:08:58 INFO - PROCESS | 1659 | |12;stanford-crypto-pbkdf2;175;172;175;212;235;232;169;172;174;176 13:08:58 INFO - PROCESS | 1659 | |13;stanford-crypto-sha256-iterative;68;69;67;68;68;68;67;67;66;67 13:08:58 INFO - PROCESS | 1659 | __end_tp_report 13:08:58 INFO - PROCESS | 1659 | __start_cc_report 13:08:58 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,1934 13:08:58 INFO - PROCESS | 1659 | __end_cc_report 13:08:58 INFO - PROCESS | 1659 | __startTimestamp1484860138246__endTimestamp 13:08:58 INFO - PROCESS | 1659 | 13:08:58 INFO - PROCESS | 1659 | ------- Summary: start ------- 13:08:58 INFO - PROCESS | 1659 | Number of tests: 14 13:08:58 INFO - PROCESS | 1659 | 13:08:58 INFO - PROCESS | 1659 | [#0] ai-astar Cycles:10 Average:122.90 Median:113.50 stddev:21.03 (18.5%) stddev-sans-first:21.78 13:08:58 INFO - PROCESS | 1659 | Values: 110.0 112.0 116.0 158.0 167.0 113.0 114.0 113.0 113.0 113.0 13:08:58 INFO - PROCESS | 1659 | 13:08:58 INFO - PROCESS | 1659 | [#1] audio-beat-detection Cycles:10 Average:118.70 Median:112.00 stddev:15.11 (13.5%) stddev-sans-first:13.22 13:08:58 INFO - PROCESS | 1659 | Values: 143.0 110.0 108.0 146.0 114.0 110.0 108.0 109.0 130.0 109.0 13:08:58 INFO - PROCESS | 1659 | 13:08:58 INFO - PROCESS | 1659 | [#2] audio-dft Cycles:10 Average:183.20 Median:183.50 stddev:2.20 (1.2%) stddev-sans-first:2.24 13:08:58 INFO - PROCESS | 1659 | Values: 185.0 184.0 181.0 188.0 183.0 183.0 181.0 182.0 181.0 184.0 13:08:58 INFO - PROCESS | 1659 | 13:08:58 INFO - PROCESS | 1659 | [#3] audio-fft Cycles:10 Average:72.60 Median:79.50 stddev:11.83 (14.9%) stddev-sans-first:12.32 13:08:58 INFO - PROCESS | 1659 | Values: 79.0 58.0 59.0 86.0 62.0 77.0 82.0 80.0 85.0 58.0 13:08:58 INFO - PROCESS | 1659 | 13:08:58 INFO - PROCESS | 1659 | [#4] audio-oscillator Cycles:10 Average:75.70 Median:76.50 stddev:8.25 (10.8%) stddev-sans-first:7.21 13:08:58 INFO - PROCESS | 1659 | Values: 89.0 71.0 86.0 70.0 68.0 70.0 82.0 69.0 69.0 83.0 13:08:58 INFO - PROCESS | 1659 | 13:08:58 INFO - PROCESS | 1659 | [#5] imaging-gaussian-blur Cycles:10 Average:87.90 Median:89.00 stddev:1.66 (1.9%) stddev-sans-first:1.58 13:08:58 INFO - PROCESS | 1659 | Values: 90.0 87.0 90.0 87.0 89.0 86.0 89.0 86.0 89.0 86.0 13:08:58 INFO - PROCESS | 1659 | 13:08:58 INFO - PROCESS | 1659 | [#6] imaging-darkroom Cycles:10 Average:94.30 Median:94.50 stddev:0.67 (0.7%) stddev-sans-first:0.67 13:08:58 INFO - PROCESS | 1659 | Values: 95.0 94.0 93.0 95.0 94.0 94.0 95.0 95.0 94.0 94.0 13:08:58 INFO - PROCESS | 1659 | 13:08:58 INFO - PROCESS | 1659 | [#7] imaging-desaturate Cycles:10 Average:97.40 Median:85.50 stddev:21.18 (24.8%) stddev-sans-first:21.90 13:08:58 INFO - PROCESS | 1659 | Values: 84.0 88.0 87.0 84.0 86.0 85.0 87.0 100.0 133.0 140.0 13:08:58 INFO - PROCESS | 1659 | 13:08:58 INFO - PROCESS | 1659 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.00 stddev:0.95 (1.7%) stddev-sans-first:1.00 13:08:58 INFO - PROCESS | 1659 | Values: 55.0 54.0 53.0 55.0 54.0 56.0 55.0 55.0 54.0 56.0 13:08:58 INFO - PROCESS | 1659 | 13:08:58 INFO - PROCESS | 1659 | [#9] json-stringify-tinderbox Cycles:10 Average:70.40 Median:71.50 stddev:3.34 (4.7%) stddev-sans-first:2.62 13:08:58 INFO - PROCESS | 1659 | Values: 64.0 72.0 76.0 72.0 72.0 66.0 71.0 71.0 70.0 70.0 13:08:58 INFO - PROCESS | 1659 | 13:08:58 INFO - PROCESS | 1659 | [#10] stanford-crypto-aes Cycles:10 Average:88.50 Median:89.00 stddev:2.51 (2.8%) stddev-sans-first:2.60 13:08:58 INFO - PROCESS | 1659 | Values: 90.0 87.0 86.0 86.0 91.0 87.0 88.0 86.0 92.0 92.0 13:08:58 INFO - PROCESS | 1659 | 13:08:58 INFO - PROCESS | 1659 | [#11] stanford-crypto-ccm Cycles:10 Average:149.40 Median:144.50 stddev:18.61 (12.9%) stddev-sans-first:19.59 13:08:58 INFO - PROCESS | 1659 | Values: 143.0 138.0 143.0 146.0 148.0 131.0 139.0 140.0 190.0 176.0 13:08:58 INFO - PROCESS | 1659 | 13:08:58 INFO - PROCESS | 1659 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.20 Median:175.50 stddev:26.37 (15.0%) stddev-sans-first:27.46 13:08:58 INFO - PROCESS | 1659 | Values: 175.0 172.0 175.0 212.0 235.0 232.0 169.0 172.0 174.0 176.0 13:08:58 INFO - PROCESS | 1659 | 13:08:58 INFO - PROCESS | 1659 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:68.00 stddev:0.85 (1.2%) stddev-sans-first:0.88 13:08:58 INFO - PROCESS | 1659 | Values: 68.0 69.0 67.0 68.0 68.0 68.0 67.0 67.0 66.0 67.0 13:08:58 INFO - PROCESS | 1659 | -------- Summary: end -------- 13:08:58 INFO - PROCESS | 1659 | 13:08:59 INFO - TEST-INFO | 1659: exit 0 13:08:59 INFO - TEST-OK | kraken | took 59759ms 13:08:59 INFO - SUITE-END | took 1177s 13:08:59 INFO - Completed test suite (00:19:38) 13:08:59 INFO - javascript benchmark 13:08:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3275.8034517928913, 3285.86856525739, 3287.704106630404, 3296.373688999089, 3347.0, 5495.422980587041, 5537.501624853762, 5596.216529685842, 5614.9438505614935, 5619.971900140498, 5524.364698059724, 5585.916211256825, 5588.888222235563, 5591.7483713232905, 5592.664440133595, 5043.546080852722, 5073.797048118071, 5078.669886457368, 5131.640785145041, 5171.818986335479, 5142.151544995071, 5169.353830771153, 5183.067047931371, 5229.503197196279, 5231.895362092756, 5215.087359712035, 5242.79028838846, 5269.0, 5270.657407268534, 5299.735013249341, 4401.339799030171, 5221.190715439113, 5236.581073514109, 5240.52835244826, 5259.658122222043, 302.4378414075288, 5058.0895438821, 5124.205748109049, 5157.71632560209, 5176.301199338079, 4713.693609915379, 5607.887842243133, 5646.040173170571, 5658.575606829463, 5695.800646977336, 6227.346128656471, 6233.532485063593, 6238.812835614939, 6245.906311405332, 6252.843678908018, 6127.5404344674325, 6221.471174950135, 6240.875182496325, 6272.18461599989, 6282.560220784547, 5659.179418984224, 5696.430356964353, 5720.11338242573, 5727.656340619576, 5748.0, 6250.843728906813, 6262.843428914222, 6273.12176295319, 6282.465990390868, 6284.874302513924, 6057.878842423127, 6104.20645316106, 6107.236595425572, 6110.144579758838, 6118.0, 5479.698616576047, 5815.0, 6042.788502402394, 6124.0, 6170.629762214281, 6133.509319254449, 6153.29237137726, 6157.199564056644, 6166.691665416801, 6173.475254603409, 6170.0, 6174.536909731788, 6191.783287584913, 6201.069839524108, 6202.379762023852, 4625.542953969489, 4813.061453016699, 4852.539008794159, 4875.341828853059, 4888.2178851383605, 4333.43665323506, 4339.0, 4364.10535840152, 4406.669499787528, 4465.709728867613, 5462.579729270339, 5616.887662246732, 5674.205611214434, 5730.083186690193, 5757.453041961007, 5496.532794712414, 6139.338817383189, 6142.069075791497, 6150.415710507495, 6152.230971128609, 5669.31968163823, 5713.657180569096, 5760.711964401847, 5767.134929760486, 5807.88384232313, 5286.497782710637, 5339.225812257201, 5359.866003349869, 5377.7311134443125, 5378.650387724863, 6200.255969283715, 6220.595661282002, 6267.122602835698, 6275.0, 6319.842003949938, 6136.028952951454, 6146.877062458636, 6147.708981114016, 6150.04674275488, 6152.354002829638, 6282.748690052346, 6292.811215663537, 6294.622322660472, 6298.370162983665, 6361.459275961595, 5983.461488465885, 6072.787452439144, 6104.603200791934, 6105.297890742621, 6164.660943648142, 6105.399096011559, 6127.036821038878, 6143.327652471189, 6146.262448506208, 6164.47601953839, 5213.843584692465, 5263.868403289948, 5932.762689492372, 6076.787312444043, 6102.0541816018585, 5944.821655350346, 6018.0, 6040.577159598786, 6043.516518678407, 6044.879102418015, 5727.541796656341, 5783.392743762012, 5822.650640961556, 5827.329857066322, 5859.296884373903, 6051.273847138372, 6056.636601803906, 6067.605605635619, 6069.605475644069, 6104.969475152596, 5825.475707186373, 5859.5019423347785, 5861.824145275648, 5868.94131058701, 5878.441548052928], "value": 5584.442427138171, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [467.5091154287999, 491.9606431485482, 502.2466300549175, 507.28472853276867, 508.60583048137664, 30970.53544196836, 39605.60394396055, 42143.578564214346, 42158.0, 42298.0, 42746.572534274645, 43057.35413968793, 43130.13739725204, 43162.92092697684, 43240.13519729603, 9121.40710853794, 9292.535373231345, 9320.161185493303, 9344.018878017812, 9352.111549402829, 8339.95830020852, 8555.10171432, 9282.396644218137, 11047.72380690481, 11334.886651133507, 11219.66341009771, 11270.492827822727, 11272.436378181099, 11284.943575282112, 11313.377764222965, 11160.888391116107, 11219.439028048564, 11225.60710375137, 11231.831522527169, 11250.3812290324, 8301.96225471816, 8513.957430212871, 10903.781924361469, 11136.944315278453, 11204.21570490066, 41033.79483102595, 41434.0, 41473.79263103665, 41515.792421038, 41591.792041039604, 4029.8388064477385, 4045.4336392905016, 4060.6548443382053, 4093.608173221089, 4102.589741025903, 29776.0, 30360.84819575888, 31118.844405777825, 31195.0, 31569.21076973094, 2720.7076638596704, 3141.4031334046686, 3149.7480201583817, 3176.237702951298, 3283.835808209604, 451588.0, 465166.0225096626, 474471.0, 478052.0, 485631.0, 60188.0, 60491.39508604858, 60529.09206361908, 60612.393876060676, 60633.69683151556, 62934.68532657399, 63279.367206328265, 63291.0, 63357.0, 63458.0481292781, 15340.539783806504, 15768.921155394379, 15802.0, 15819.52541423759, 15822.841771582367, 12261.877381226073, 12336.0, 12361.505539778487, 12362.44369003397, 12363.196392234477, 13755.17468951846, 14139.43442262298, 14141.929290353482, 14477.710445791236, 14484.493042743454, 5680.289963754531, 6535.150430444107, 6685.331466853276, 7140.357367836919, 7261.636918154071, 865.8398196333699, 868.8740132680726, 876.8947726272888, 914.6067191107887, 918.1140199707314, 29584.408311834075, 29740.40519189604, 29978.70021299803, 30353.24116897095, 30396.54405183924, 992.2905122837062, 1074.7957888001254, 1111.2054880760134, 1123.152020224725, 1191.362620997762, 15034.69930601382, 15452.5364239073, 15499.457518986781, 15626.45307414235, 15894.364225431085, 570872.1456392691, 625560.0, 629962.0, 630395.0, 630991.0, 43732.34401483917, 53644.463555364724, 53750.7312463443, 53811.73094134583, 53994.19008714794, 1416.4121889415983, 1425.3942074618246, 1448.377197804954, 1450.108183467181, 1455.1592235821695, 27336.453270934868, 28275.648331434386, 28617.28456788597, 28642.0, 28645.856770716015, 45055.0988980212, 45272.32091518696, 45527.54472455233, 45537.77231113823, 45777.77111114423, 532222.6944326268, 533687.0, 535039.0, 535986.0, 537295.0, 19815.702764458834, 23709.288721338387, 24725.629115562922, 25013.374665633506, 25672.871635641703, 35190.768323109594, 38759.03102422349, 41606.37590436207, 43525.56474435215, 45412.54587454216, 35771.64228357683, 35863.64136358603, 36050.0, 36780.0, 36942.630573694994, 35484.82257588695, 36002.45996310005, 36211.27577448384, 36357.45463817992, 36944.89165324937, 34485.48271775875, 35078.824605876805, 35442.468362975094, 35729.64270357367, 35797.0, 30047.699523005365, 31114.533282000335, 31837.20406989844, 32109.03672889817, 32196.517052243766, 22718.65922011138, 23441.648375274726, 23528.882355588114, 23569.292921212393, 23598.29205123849], "value": 19433.50229485844, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.5871824451536, 382.9195868867538, 392.69762283042047, 405.24826446940904, 414.2894935186157, 18884.62230755384, 21648.567028659458, 21687.24094656687, 21814.345569632897, 21951.780482195194, 21397.57204855902, 21819.0, 22033.33899982999, 22246.777532224714, 22381.0, 5288.233206185101, 5775.797847075332, 5838.2994040715175, 5865.120231965218, 5871.412858714137, 4153.0863210093885, 4248.426462427564, 4351.325544540601, 5711.942880571182, 5746.913796293059, 4352.020795321059, 4386.451693538308, 6430.549861509696, 6433.195850518685, 6437.83905402364, 6157.507399408037, 6321.146645202884, 6412.935870641304, 6421.325760795096, 6423.839404014913, 5633.8591535211535, 5635.464630860061, 5645.294338207724, 5645.633033852828, 5648.237487939158, 25011.62482562745, 25062.12282570101, 25399.873000635063, 25633.871830640914, 25648.61527077095, 2733.5079685656574, 2788.553831386989, 2790.748832605055, 2817.112609527992, 2844.132539575429, 15329.386824527006, 15685.764713529306, 15770.921145394313, 16127.919360403122, 16516.50450486475, 1768.8142745011717, 1809.0, 1811.5199472139893, 1815.636872625467, 1818.5817262029675, 132363.0, 135546.32226838902, 135658.6434135656, 136406.0, 137720.6227937718, 11184.608538701106, 11472.54109835614, 11550.653480395602, 11590.13074019435, 11784.116191285688, 14611.78082328766, 14629.341679624229, 14640.487582934758, 14642.780358294634, 14669.0, 8132.471389359673, 8336.374771892133, 8581.442206256697, 8600.655973761104, 8646.783830404165, 8460.492370457792, 8479.152084791594, 8511.787205319793, 8660.0, 8688.174623410765, 6591.91233446476, 6620.4041636252, 6971.058907047585, 7109.431245500347, 7132.393746531603, 1895.8293753562245, 1930.3147382678947, 1944.8541359398102, 1948.5518330783998, 1950.570874407628, 1050.5850189175233, 1065.211743309945, 1069.7218723132041, 1075.3279200499687, 1115.0577761791274, 20841.89579052095, 23120.4219894504, 23142.42143946415, 23212.071517139462, 23259.06963721466, 1078.7734575739182, 1081.859358283418, 1114.3703807348822, 1121.1647322744607, 1139.9886001140048, 10708.449295314174, 11165.218434709492, 11960.15940229134, 12114.81827772584, 12149.392530373623, 709519.0, 709890.0, 723232.0, 725043.0, 738716.0, 125508.0, 129158.35420822835, 156521.0, 168139.0, 168930.0, 442.90256143648344, 462.7131178669179, 464.9767511624473, 465.12788521522145, 467.9938133014115, 10459.633912813015, 11451.14116441287, 11587.130965177814, 11849.822252666045, 11945.402729863647, 45972.0, 56682.433175669365, 58196.709016454646, 59537.7023114899, 60016.39983600108, 87247.0, 87285.0, 88793.55603221942, 89093.0, 90834.54582727309, 8420.831583368421, 8509.0, 8652.524111173694, 8709.303255739398, 8870.86693699582, 12726.427310771223, 12967.0, 13467.932660336635, 13495.865041349854, 13902.652433689238, 11340.489677964346, 11436.19946603763, 11766.941165294462, 11828.17202795796, 11982.820257696316, 11203.88796112061, 11334.773304534028, 11591.536338546364, 11622.535098595961, 11654.242474239147, 11094.223404361617, 11235.55057797679, 11551.133664974992, 11639.301641901513, 11852.170348075897, 7935.2064793520185, 8360.958195208985, 8507.702230421906, 8641.012567109725, 8690.174433428814, 9074.45553266806, 11666.416679166177, 11788.823167652663, 11856.466459009538, 11906.940465297617], "value": 9891.92935539182, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1474.542891703572, 1480.8445113263115, 1485.331600779649, 1500.2498750624682, 1504.2102895979613, 8119.066307374654, 8491.023532293788, 8503.2347088762, 8519.275861551769, 8525.445846020004, 7405.666744996474, 7655.0, 7661.46369754116, 8079.596020198996, 8318.625661845217, 2258.9661155082686, 2309.226409152936, 2312.1560630369877, 2315.872627005514, 2319.6752454656275, 2308.2152068296778, 2308.272894038381, 2328.161861729776, 2334.124703236286, 2335.6963594732747, 2274.056266649347, 2280.5552917181158, 2297.6094064009158, 2299.379167624749, 2301.3211102724654, 2096.6330892093824, 2120.2579097315893, 2130.8508404411696, 2133.4559687279643, 2142.710734050914, 1979.3369221310877, 2012.2655230840785, 2171.8489200723643, 2330.8251881108986, 2332.3586013846157, 8426.410151289412, 8454.87317690235, 8475.788105297355, 8475.915240847575, 8488.872666910001, 4978.128827455217, 5154.742262886841, 5158.432572417031, 5159.277701121846, 5166.276721259027, 3177.189816596753, 3304.653011433813, 3468.1156305142026, 3519.208178159919, 3524.7356448266482, 1157.7163594919214, 1197.0543270816045, 1198.6284251881857, 1250.4623012104792, 1260.0864373329264, 9798.922118566952, 10271.691849244535, 10733.570657173703, 10829.783404331947, 10853.0, 4405.251107311765, 4587.632989360844, 4668.3697700810635, 4678.391809064799, 4679.766011699469, 9441.24470042395, 9446.055394460498, 9465.0, 9477.526123693788, 9486.146246837818, 5198.4801519847715, 5211.843644690665, 5216.478352164829, 5218.582513398995, 5227.947720522822, 3814.675752561008, 4216.283231850532, 4649.604783593365, 4689.812407503729, 4753.714777113315, 3773.6226377362045, 3791.3554695701796, 3882.96117038826, 3893.824777885002, 3917.471141395932, 1074.3500182389541, 1106.8395082713123, 1280.7566562353122, 1286.1511402474323, 1293.683047653331, 688.7520492622651, 859.8151397449578, 906.1210625693067, 915.3226612306845, 942.5617088054088, 5171.301874247004, 5301.1783173608155, 5551.611387202938, 5632.690202038927, 5708.57185711065, 830.5009457928377, 897.4839467306325, 902.1835239108617, 965.4400447740434, 986.8766404199475, 3422.691957723767, 3680.8895733128047, 3728.813559322023, 3799.240151969562, 3807.0, 9635.470049147223, 9961.302708810459, 10005.04952029556, 10041.949790251148, 10054.648087317055, 9961.302708810459, 9961.750956226153, 9978.251631127549, 9980.80038399228, 9980.950095249478, 7312.926870731225, 7693.884591731128, 7744.7676569703, 7883.132855385903, 7892.881606775903, 5461.481159289861, 5571.498565128995, 5617.297837770278, 5646.576506761927, 5776.42235776419, 8750.343724220837, 8897.199252067345, 8976.102389760972, 9127.726168214964, 9139.908600914172, 8950.86573701408, 9118.17936385702, 9372.625094996123, 9440.905590944278, 9465.621375144918, 6526.347365263626, 6749.797506074826, 6751.93248067513, 6982.092327997328, 7231.819204519718, 7610.885836712565, 7888.723894663659, 7914.802129946567, 7990.800229994296, 8010.599470026359, 7015.6842942066705, 7138.535995160298, 7157.606331651601, 7184.892226616709, 7275.854482910207, 6849.897251541331, 7007.7196912122945, 7008.5094043416475, 7080.04419403374, 7108.182559005573, 5538.390777014606, 6257.124002639725, 6298.212723409574, 6351.872962540816, 6385.96807015962, 4672.598220533759, 4919.3604831371695, 4939.901201975868, 4993.425756038102, 5050.3182070420025, 4715.669903106749, 4859.343988561499, 4861.7326047066335, 4937.23472861707, 4946.208606622923], "value": 4366.484551192153, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.6304517211756, 349.69751165242064, 358.1368900948713, 365.0963864435521, 367.14272174472603, 5167.767450464728, 5171.276021357013, 5234.790608375661, 5243.303471052908, 5251.396089449714, 4137.317342638468, 4286.228478873802, 4539.276434139515, 4592.701474404162, 4969.602431805456, 4012.7792971386634, 4014.658754005913, 4072.328065869143, 4075.982388717589, 4102.282100632392, 3793.525809273841, 3816.0313274194805, 4017.718759686823, 4047.797610119482, 4074.6129117733767, 3704.8332825022803, 3898.9805050974846, 4015.2571774221715, 4027.7784721840285, 4035.354343305072, 3318.8340582970877, 3550.9644903550893, 3904.492415985904, 3906.4921560196995, 3940.2119576084897, 3163.1775738308206, 3369.107186595554, 3385.4414021686393, 3399.1814379307198, 3401.9829900850586, 4373.978130109361, 4591.4260717410325, 4790.712557246577, 4999.675021123615, 5010.774515146791, 4199.7610704842145, 4437.889052773674, 4439.289713645801, 4454.7995340209445, 4498.672891497016, 4438.0014496738295, 5311.601629877736, 5315.893682126336, 5383.16560933056, 5420.864478388072, 3189.7607679423904, 3680.7975561344115, 3708.8516459341595, 3743.887683369503, 3768.3782175940937, 5237.931017248204, 5318.936212757425, 5646.943530564683, 5679.148127780824, 5709.42905709434, 3499.8625446729916, 3635.2729454109285, 3742.3450896093077, 3753.981230093832, 3780.4518344839844, 3807.676347510437, 3828.75113117652, 3830.8276127573768, 3831.272058308912, 3835.7150354630953, 3614.313280476701, 3926.509186351706, 4076.7553946763287, 4096.3036283831225, 4444.977655139336, 4803.486901626046, 5138.460461651547, 5347.556159836822, 5473.917891231635, 5478.643888147258, 1229.8193734015445, 1237.870023647522, 1242.912996090265, 1243.5088140184575, 1253.6865783554113, 682.0757873082001, 801.9398545109024, 827.606886728799, 832.3216578488513, 844.6494704697482, 4062.471878655815, 4364.825406983685, 4784.401949756211, 4786.8085276588545, 4798.2082956311815, 4649.396338050635, 5193.454687257859, 5246.898151388251, 5288.055667950479, 5360.981413531416, 4259.381435054659, 4600.2869555218995, 4666.1834179019215, 4755.690880092783, 4765.1660959331975, 2388.9283321500384, 2553.080890879319, 2786.5959435882087, 2788.5817127431046, 2791.4696207720467, 4802.543758342952, 5132.615053870974, 5276.709780962007, 5353.491418315254, 5545.085060964896, 4664.720116793003, 4913.631477639191, 5202.271681964528, 5285.436563266812, 5485.177223416519, 4316.568343165658, 5293.285406470154, 5305.912287981032, 5429.294191755047, 5549.306336707992, 4949.802007919643, 5050.49495050492, 5152.793888244578, 5263.447338029452, 5359.732013399236, 4312.7627980461375, 4605.930911036404, 4820.373351464287, 4867.641327484024, 4942.802287908444, 4887.437944636412, 4925.0, 5222.843314700565, 5577.414371490935, 5582.33012038558, 3121.814729689181, 3336.9833150834093, 3541.3625547401716, 3570.892873213808, 3580.0846547097176, 4500.504944456173, 4819.481778301789, 4913.213885778258, 5015.398152221611, 5265.473452654704, 4759.357486739246, 5098.668586541863, 5107.799667078308, 5110.850058736754, 5155.845324640267, 4294.0, 4984.4517103117905, 5035.571976382049, 5073.6513900825275, 5083.237514372874, 3948.0, 4522.63818894481, 4753.6452111148155, 4893.947801222755, 4936.950630493649, 4592.908141837212, 5264.947350526446, 5267.313670028237, 5287.488442989549, 5387.892242155057, 5057.721825299644, 5247.344081989751, 5310.522053015247, 5323.653962492425, 5323.707196104251], "value": 3842.438674779848, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [724.4096061709706, 769.507515190278, 783.5377127494777, 837.8910741603592, 843.8185790055137, 14496.420143194273, 15359.462418815316, 15397.0, 15445.691086178284, 15450.690986180283, 14142.363593638285, 14308.141511509317, 14309.284535773195, 14311.499097531589, 14325.641858953531, 692.407991167552, 708.9113860767404, 709.652270387509, 863.8013256950906, 875.0199776250608, 883.9513826739527, 898.5821592959272, 899.4603238057146, 900.5902314446944, 901.5041727050129, 951.9904800951971, 952.7284723853703, 954.6944977607169, 958.8657587937695, 961.9182369498566, 722.1839321566648, 735.1141874041767, 906.9773255668595, 948.9703671516413, 953.408886490377, 695.2803848017278, 698.0297386632585, 700.5061431690646, 700.908881845362, 704.0530486495707, 14770.0, 15097.849021509754, 15125.848741512555, 15144.772828407582, 15147.54557363281, 13752.0, 13792.0, 13802.723945521133, 13935.372908219155, 13953.651158721113, 12784.680382990407, 12881.291528965903, 12976.026797990095, 13168.86831131686, 13284.53504127351, 4439.511653718088, 4482.932756008662, 4511.554830754547, 4572.3827283317, 4707.482176960531, 105597.0, 108631.0, 111255.44372278168, 111701.44149279202, 113368.0, 10858.511366988505, 10984.133588939523, 11019.614313498989, 11221.990020898158, 11257.887421125848, 21796.564068718853, 22299.777002230094, 22306.888465557568, 22338.55322893533, 22414.0, 6346.682665866688, 7708.344790692854, 7749.380049596019, 7801.765947021599, 7828.138904720477, 4223.788810559459, 4236.2586547354085, 4301.526832048472, 4311.288637374798, 4400.867973960786, 3417.743669224818, 3525.682688557991, 3531.4702794581017, 3551.236484155919, 3819.3698039823116, 716.7634680555404, 726.4551586310267, 734.3170851108521, 742.1539445032668, 743.3087228877196, 613.411125319698, 665.8069159943659, 691.3190507350256, 695.5305169010898, 700.3661686174021, 10229.130523905551, 10417.895821041693, 10444.21668374875, 10588.470576471145, 10648.467576621139, 666.2271764752863, 711.7259854955879, 717.9712811487482, 723.5803234124301, 732.5934106570904, 4908.141075311806, 5087.87280317995, 5093.847184584469, 5109.4379618241965, 5120.7951681933055, 82727.0, 101832.47251291237, 104283.0, 104890.0, 106030.8064572584, 64691.67654161699, 89935.55032224928, 90936.0, 91336.0, 92748.53625731828, 77715.0, 78176.60911695405, 79412.60293698494, 79662.0, 80701.19298807054, 9760.707178784647, 9762.951185244028, 9788.951055244679, 9805.754856128653, 9818.0, 44554.77722611366, 45000.32499512575, 45331.0, 49439.50560494349, 49849.252261215384, 64037.0, 64773.67613161904, 68357.3164268351, 68787.65606172137, 69668.0, 11762.470878786045, 12159.45282462309, 13130.606081817561, 13229.47082116743, 13512.0, 11975.940120299343, 14868.85131148718, 15015.390725846402, 15104.0, 15135.394584216509, 13799.0, 13805.51680691171, 13905.791413128609, 14026.22855742944, 14166.929165354108, 13865.376058077612, 13969.58091257264, 14172.645683857985, 14204.78692819588, 14437.566872993826, 13392.799108013582, 13758.587242382744, 13781.104228225133, 14125.364358604093, 14218.928905355408, 10818.729531761768, 11289.784080886422, 11508.314665043268, 11587.304761714324, 11627.360495172847, 11012.779744404907, 11228.775424491629, 11255.887441125484, 11271.943640281746, 11276.830847537458], "value": 7651.416778676797, "unit": "score"}], "name": "dromaeo_css", "value": 7187.158473489045, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 112.0, 116.0, 158.0, 167.0, 113.0, 114.0, 113.0, 113.0, 113.0], "value": 122.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 110.0, 108.0, 146.0, 114.0, 110.0, 108.0, 109.0, 130.0, 109.0], "value": 118.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 181.0, 188.0, 183.0, 183.0, 181.0, 182.0, 181.0, 184.0], "value": 183.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 58.0, 59.0, 86.0, 62.0, 77.0, 82.0, 80.0, 85.0, 58.0], "value": 72.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 71.0, 86.0, 70.0, 68.0, 70.0, 82.0, 69.0, 69.0, 83.0], "value": 75.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 90.0, 87.0, 89.0, 86.0, 89.0, 86.0, 89.0, 86.0], "value": 87.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 93.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 88.0, 87.0, 84.0, 86.0, 85.0, 87.0, 100.0, 133.0, 140.0], "value": 97.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 53.0, 55.0, 54.0, 56.0, 55.0, 55.0, 54.0, 56.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 72.0, 76.0, 72.0, 72.0, 66.0, 71.0, 71.0, 70.0, 70.0], "value": 70.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 86.0, 86.0, 91.0, 87.0, 88.0, 86.0, 92.0, 92.0], "value": 88.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 138.0, 143.0, 146.0, 148.0, 131.0, 139.0, 140.0, 190.0, 176.0], "value": 149.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 172.0, 175.0, 212.0, 235.0, 232.0, 169.0, 172.0, 174.0, 176.0], "value": 189.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 67.0, 68.0, 68.0, 68.0, 67.0, 67.0, 66.0, 67.0], "value": 67.5, "unit": "score"}], "name": "kraken", "value": 1472.4, "alertThreshold": 2.0}]} 13:08:59 INFO - Return code: 0 13:08:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:08:59 ERROR - # TBPL SUCCESS # 13:08:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:08:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:08:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:08:59 INFO - 2017-01-19 13:08:59.584 screenresolution[1663:10754] starting screenresolution argv=screenresolution get 13:08:59 INFO - 2017-01-19 13:08:59.587 screenresolution[1663:10754] Display 0: 1600x1200x32@60 13:08:59 INFO - 2017-01-19 13:08:59.593 screenresolution[1664:10757] starting screenresolution argv=screenresolution list 13:08:59 INFO - Available Modes on Display 0 13:08:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:08:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:08:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:08:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:08:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:08:59 INFO - Intel Iris: 13:08:59 INFO - Chipset Model: Intel Iris 13:08:59 INFO - Type: GPU 13:08:59 INFO - Bus: Built-In 13:08:59 INFO - VRAM (Dynamic, Max): 1536 MB 13:08:59 INFO - Vendor: Intel (0x8086) 13:08:59 INFO - Device ID: 0x0a2e 13:08:59 INFO - Revision ID: 0x0009 13:08:59 INFO - Displays: 13:08:59 INFO - Display: 13:08:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:08:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:08:59 INFO - Display Serial Number: 1600x1200 60 13:08:59 INFO - Main Display: Yes 13:08:59 INFO - Mirror: Off 13:08:59 INFO - Online: Yes 13:08:59 INFO - Rotation: Supported 13:08:59 INFO - Return code: 0 13:08:59 INFO - Running post-action listener: _resource_record_post_action 13:08:59 INFO - [mozharness: 2017-01-19 21:08:59.832913Z] Finished run-tests step (success) 13:08:59 INFO - Running post-run listener: _resource_record_post_run 13:08:59 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 31329280; Write bytes: 551728640; Read time: 202; Write time: 1706 13:08:59 INFO - TinderboxPrint: CPU usage
54.0% 13:08:59 INFO - TinderboxPrint: I/O read bytes / time
31,329,280 / 202 13:08:59 INFO - TinderboxPrint: I/O write bytes / time
551,728,640 / 1,706 13:08:59 INFO - TinderboxPrint: CPU idle
2,208.1 (46.0%) 13:08:59 INFO - TinderboxPrint: CPU system
963.8 (20.1%) 13:08:59 INFO - TinderboxPrint: CPU user
1,629.8 (33.9%) 13:08:59 INFO - TinderboxPrint: Swap in / out
278,327,296 / 0 13:08:59 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 249244160; Write bytes: 244310016; Read time: 18010; Write time: 533 13:08:59 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 29023232; Write bytes: 295843328; Read time: 175; Write time: 1137 13:09:00 INFO - Running post-run listener: _upload_blobber_files 13:09:00 INFO - Blob upload gear active. 13:09:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:09:00 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 13:09:00 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'] 13:09:00 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 13:09:00 INFO - (blobuploader) - INFO - Open directory for files ... 13:09:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:09:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:09:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:09:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:09:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:09:01 INFO - (blobuploader) - INFO - Done attempting. 13:09:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:09:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:09:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:09:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:09:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:09:02 INFO - (blobuploader) - INFO - Done attempting. 13:09:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:09:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:09:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:09:03 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:09:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:09:03 INFO - (blobuploader) - INFO - Done attempting. 13:09:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:09:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:09:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:09:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:09:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:09:06 INFO - (blobuploader) - INFO - Done attempting. 13:09:06 INFO - (blobuploader) - INFO - Iteration through files over. 13:09:06 INFO - Return code: 0 13:09:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:09:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:09:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/014c9b98237f886eb10829a42a33afe9f62e45235d3e0bb841855b209f443d799712c82f636c688ef72d26ba05fb00b169f7c9ff73717f1d2a8a3914cbf263ef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/691e2219a13a9f7a7a66f8c59480f6a7d00e0a15c96efb7507b9437aed967e7bfb8876ebe2e0ef7ae0430b268e37b8cbb1783bc851489f3629b3da20098e1cca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f88e82c2e55fdd805bc949300c6d9b00b2c605d01ddb4d895b86b3b94c160284df67540ad4c3c4a5151052753089189f80cc4fc4abc827f4594c70dbe9f7cb29", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a72e17202db8ebd5cf22ce9f075b25d962614a08762ff3b0cbe4772753a0861a4b10df9f39b637a33ca92fd44e670ca6bacf11c54116a073020bd37e9e6ab345"} 13:09:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:09:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:09:06 INFO - Contents: 13:09:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/014c9b98237f886eb10829a42a33afe9f62e45235d3e0bb841855b209f443d799712c82f636c688ef72d26ba05fb00b169f7c9ff73717f1d2a8a3914cbf263ef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/691e2219a13a9f7a7a66f8c59480f6a7d00e0a15c96efb7507b9437aed967e7bfb8876ebe2e0ef7ae0430b268e37b8cbb1783bc851489f3629b3da20098e1cca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f88e82c2e55fdd805bc949300c6d9b00b2c605d01ddb4d895b86b3b94c160284df67540ad4c3c4a5151052753089189f80cc4fc4abc827f4594c70dbe9f7cb29", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a72e17202db8ebd5cf22ce9f075b25d962614a08762ff3b0cbe4772753a0861a4b10df9f39b637a33ca92fd44e670ca6bacf11c54116a073020bd37e9e6ab345"} 13:09:06 INFO - Running post-run listener: copy_logs_to_upload_dir 13:09:06 INFO - Copying logs to upload dir... 13:09:06 INFO - mkdir: /builds/slave/test/build/upload/logs 13:09:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.032526 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-01-19 13:09:06.808626) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-19 13:09:06.812267) ========= 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.ucF2zlRaiE/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.hV69cLB9B1/Listeners TMPDIR=/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/014c9b98237f886eb10829a42a33afe9f62e45235d3e0bb841855b209f443d799712c82f636c688ef72d26ba05fb00b169f7c9ff73717f1d2a8a3914cbf263ef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/691e2219a13a9f7a7a66f8c59480f6a7d00e0a15c96efb7507b9437aed967e7bfb8876ebe2e0ef7ae0430b268e37b8cbb1783bc851489f3629b3da20098e1cca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f88e82c2e55fdd805bc949300c6d9b00b2c605d01ddb4d895b86b3b94c160284df67540ad4c3c4a5151052753089189f80cc4fc4abc827f4594c70dbe9f7cb29", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a72e17202db8ebd5cf22ce9f075b25d962614a08762ff3b0cbe4772753a0861a4b10df9f39b637a33ca92fd44e670ca6bacf11c54116a073020bd37e9e6ab345"} build_url:https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011118 build_url: 'https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/014c9b98237f886eb10829a42a33afe9f62e45235d3e0bb841855b209f443d799712c82f636c688ef72d26ba05fb00b169f7c9ff73717f1d2a8a3914cbf263ef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/691e2219a13a9f7a7a66f8c59480f6a7d00e0a15c96efb7507b9437aed967e7bfb8876ebe2e0ef7ae0430b268e37b8cbb1783bc851489f3629b3da20098e1cca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f88e82c2e55fdd805bc949300c6d9b00b2c605d01ddb4d895b86b3b94c160284df67540ad4c3c4a5151052753089189f80cc4fc4abc827f4594c70dbe9f7cb29", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a72e17202db8ebd5cf22ce9f075b25d962614a08762ff3b0cbe4772753a0861a4b10df9f39b637a33ca92fd44e670ca6bacf11c54116a073020bd37e9e6ab345"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-19 13:09:06.851788) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 13:09:06.852408) ========= 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.ucF2zlRaiE/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.hV69cLB9B1/Listeners TMPDIR=/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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.005209 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 13:09:06.904243) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-19 13:09:06.905019) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-19 13:09:06.905813) ========= ========= Total master_lag: 0.24 =========