builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0264 starttime: 1482299920.12 results: success (0) buildid: 20161220201353 builduid: 856c8a10b3e24fb69d4abe6b477e9266 revision: 20774bffb62a3c1fecf98ed8ad9ee1a861bcd9b7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-20 21:58:40.124220) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-20 21:58:40.124671) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-20 21:58:40.124964) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-20 21:58:40.156189) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 21:58:40.156571) ========= 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.qa0W2EkVgN/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.9XdGcrC4mF/Listeners TMPDIR=/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 --2016-12-20 21:58:40-- 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% 171M=0s 2016-12-20 21:58:40 (171 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.125984 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 21:58:40.307900) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 21:58:40.308209) ========= 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.qa0W2EkVgN/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.9XdGcrC4mF/Listeners TMPDIR=/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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.024583 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 21:58:40.360090) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-12-20 21:58:40.362481) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 20774bffb62a3c1fecf98ed8ad9ee1a861bcd9b7 --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 20774bffb62a3c1fecf98ed8ad9ee1a861bcd9b7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qa0W2EkVgN/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.9XdGcrC4mF/Listeners TMPDIR=/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 2016-12-20 21:58:40,440 truncating revision to first 12 chars 2016-12-20 21:58:40,440 Setting DEBUG logging. 2016-12-20 21:58:40,440 attempt 1/10 2016-12-20 21:58:40,441 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/20774bffb62a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-20 21:58:41,636 unpacking tar archive at: mozilla-central-20774bffb62a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.472934 ========= master_lag: 1.88 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-12-20 21:58:43.718295) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-20 21:58:43.718622) ========= script_repo_revision: 20774bffb62a3c1fecf98ed8ad9ee1a861bcd9b7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-20 21:58:43.719055) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-20 21:58:43.723360) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-20 21:58:43.746788) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-12-20 21:58:43.747162) ========= /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.qa0W2EkVgN/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.9XdGcrC4mF/Listeners TMPDIR=/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 21:58:43 INFO - MultiFileLogger online at 20161220 21:58:43 in /builds/slave/test 21:58:43 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 21:58:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:58:43 INFO - {'append_to_log': False, 21:58:43 INFO - 'base_work_dir': '/builds/slave/test', 21:58:43 INFO - 'blob_upload_branch': 'Firefox', 21:58:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:58:43 INFO - 'branch': 'Firefox', 21:58:43 INFO - 'buildbot_json_path': 'buildprops.json', 21:58:43 INFO - 'config_files': ('talos/mac_config.py',), 21:58:43 INFO - 'default_actions': ('clobber', 21:58:43 INFO - 'read-buildbot-config', 21:58:43 INFO - 'download-and-extract', 21:58:43 INFO - 'populate-webroot', 21:58:43 INFO - 'create-virtualenv', 21:58:43 INFO - 'install', 21:58:43 INFO - 'run-tests'), 21:58:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:58:43 INFO - 'download_minidump_stackwalk': True, 21:58:43 INFO - 'download_symbols': 'ondemand', 21:58:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:58:43 INFO - 'tooltool.py': '/tools/tooltool.py', 21:58:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:58:43 INFO - '/tools/misc-python/virtualenv.py')}, 21:58:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:58:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:58:43 INFO - 'installer_path': 'installer.exe', 21:58:43 INFO - 'log_level': 'info', 21:58:43 INFO - 'log_name': 'talos', 21:58:43 INFO - 'log_to_console': True, 21:58:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:58:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:58:43 INFO - 'opt_config_files': (), 21:58:43 INFO - 'pip_index': False, 21:58:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:58:43 INFO - 'cmd': ('bash', 21:58:43 INFO - '-c', 21:58:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:58:43 INFO - 'enabled': True, 21:58:43 INFO - 'halt_on_failure': False, 21:58:43 INFO - 'name': 'check_screen_resolution'},), 21:58:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:58:43 INFO - 'cmd': ('bash', 21:58:43 INFO - '-c', 21:58:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:58:43 INFO - 'enabled': True, 21:58:43 INFO - 'halt_on_failure': False, 21:58:43 INFO - 'name': 'check_screen_resolution'},), 21:58:43 INFO - 'run_cmd_checks_enabled': True, 21:58:43 INFO - 'sps_profile': False, 21:58:43 INFO - 'sps_profile_interval': 0, 21:58:43 INFO - 'suite': 'dromaeojs', 21:58:43 INFO - 'system_bits': '32', 21:58:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:58:43 INFO - 'title': 't-yosemite-r7-0264', 21:58:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:58:43 INFO - 'use_talos_json': True, 21:58:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:58:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:58:43 INFO - 'work_dir': 'build'} 21:58:43 INFO - [mozharness: 2016-12-21 05:58:43.928533Z] Running clobber step. 21:58:43 INFO - Running pre-action listener: _resource_record_pre_action 21:58:43 INFO - Running main action method: clobber 21:58:43 INFO - rmtree: /builds/slave/test/build 21:58:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:58:46 INFO - Running post-action listener: _resource_record_post_action 21:58:46 INFO - [mozharness: 2016-12-21 05:58:46.328000Z] Finished clobber step (success) 21:58:46 INFO - [mozharness: 2016-12-21 05:58:46.328218Z] Running read-buildbot-config step. 21:58:46 INFO - Running pre-action listener: _resource_record_pre_action 21:58:46 INFO - Running main action method: read_buildbot_config 21:58:46 INFO - Using buildbot properties: 21:58:46 INFO - { 21:58:46 INFO - "project": "", 21:58:46 INFO - "product": "firefox", 21:58:46 INFO - "script_repo_revision": "production", 21:58:46 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 21:58:46 INFO - "repository": "", 21:58:46 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 21:58:46 INFO - "buildid": "20161220201353", 21:58:46 INFO - "pgo_build": "False", 21:58:46 INFO - "basedir": "/builds/slave/test", 21:58:46 INFO - "buildnumber": 35, 21:58:46 INFO - "slavename": "t-yosemite-r7-0264", 21:58:46 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 21:58:46 INFO - "platform": "yosemite_r7", 21:58:46 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 21:58:46 INFO - "branch": "mozilla-central", 21:58:46 INFO - "repo_path": "mozilla-central", 21:58:46 INFO - "revision": "20774bffb62a3c1fecf98ed8ad9ee1a861bcd9b7", 21:58:46 INFO - "stage_platform": "macosx64", 21:58:46 INFO - "builduid": "856c8a10b3e24fb69d4abe6b477e9266", 21:58:46 INFO - "slavebuilddir": "test" 21:58:46 INFO - } 21:58:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/DkyMu6TySlmVLmQyzgcaQg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 21:58:46 INFO - Running post-action listener: _resource_record_post_action 21:58:46 INFO - [mozharness: 2016-12-21 05:58:46.333864Z] Finished read-buildbot-config step (success) 21:58:46 INFO - [mozharness: 2016-12-21 05:58:46.334088Z] Running download-and-extract step. 21:58:46 INFO - Running pre-action listener: _resource_record_pre_action 21:58:46 INFO - Running main action method: download_and_extract 21:58:46 INFO - mkdir: /builds/slave/test/build/tests 21:58:46 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')]} 21:58:46 INFO - trying https://queue.taskcluster.net/v1/task/DkyMu6TySlmVLmQyzgcaQg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 21:58:46 INFO - Downloading https://queue.taskcluster.net/v1/task/DkyMu6TySlmVLmQyzgcaQg/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 21:58:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DkyMu6TySlmVLmQyzgcaQg/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 21:58:47 INFO - Downloaded 1199 bytes. 21:58:47 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 21:58:47 INFO - Using the following test package requirements: 21:58:47 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 21:58:47 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:58:47 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 21:58:47 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:58:47 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 21:58:47 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:58:47 INFO - u'jsshell-mac.zip'], 21:58:47 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:58:47 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 21:58:47 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 21:58:47 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:58:47 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 21:58:47 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:58:47 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 21:58:47 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:58:47 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 21:58:47 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:58:47 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 21:58:47 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 21:58:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DkyMu6TySlmVLmQyzgcaQg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 21:58:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DkyMu6TySlmVLmQyzgcaQg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:58:47 INFO - Fetch https://queue.taskcluster.net/v1/task/DkyMu6TySlmVLmQyzgcaQg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 21:58:48 INFO - Expected file size: 16277718 21:58:48 INFO - Obtained file size: 16277718 21:58:55 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 21:58:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DkyMu6TySlmVLmQyzgcaQg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 21:58:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DkyMu6TySlmVLmQyzgcaQg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:58:55 INFO - Fetch https://queue.taskcluster.net/v1/task/DkyMu6TySlmVLmQyzgcaQg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 21:58:56 INFO - Expected file size: 16277718 21:58:56 INFO - Obtained file size: 16277718 21:59:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DkyMu6TySlmVLmQyzgcaQg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 21:59:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DkyMu6TySlmVLmQyzgcaQg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 21:59:03 INFO - Fetch https://queue.taskcluster.net/v1/task/DkyMu6TySlmVLmQyzgcaQg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 21:59:05 INFO - Expected file size: 14409734 21:59:05 INFO - Obtained file size: 14409734 21:59:05 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')]} 21:59:05 INFO - trying https://queue.taskcluster.net/v1/task/DkyMu6TySlmVLmQyzgcaQg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 21:59:05 INFO - Downloading https://queue.taskcluster.net/v1/task/DkyMu6TySlmVLmQyzgcaQg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 21:59:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DkyMu6TySlmVLmQyzgcaQg/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 21:59:07 INFO - Downloaded 69609572 bytes. 21:59:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DkyMu6TySlmVLmQyzgcaQg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 21:59:07 INFO - mkdir: /builds/slave/test/properties 21:59:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:59:07 INFO - Writing to file /builds/slave/test/properties/build_url 21:59:07 INFO - Contents: 21:59:07 INFO - build_url:https://queue.taskcluster.net/v1/task/DkyMu6TySlmVLmQyzgcaQg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 21:59:08 INFO - Running post-action listener: _resource_record_post_action 21:59:08 INFO - Running post-action listener: set_extra_try_arguments 21:59:08 INFO - [mozharness: 2016-12-21 05:59:08.779299Z] Finished download-and-extract step (success) 21:59:08 INFO - [mozharness: 2016-12-21 05:59:08.779448Z] Running populate-webroot step. 21:59:08 INFO - Running pre-action listener: _resource_record_pre_action 21:59:08 INFO - Running main action method: populate_webroot 21:59:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:59:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:59:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:59:08 INFO - '--tppagecycles', 21:59:08 INFO - '7'], 21:59:08 INFO - 'tests': ['tsvgm']}}, 21:59:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:59:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:59:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:59:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:59:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:59:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:59:08 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 21:59:08 INFO - 'talos_options': ['--disable-e10s'], 21:59:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:59:08 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 21:59:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:59:08 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 21:59:08 INFO - 'talos_options': ['--disable-e10s'], 21:59:08 INFO - 'tests': ['damp', 'tps']}, 21:59:08 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 21:59:08 INFO - 'tests': ['damp', 'tps']}, 21:59:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:59:08 INFO - 'tests': ['dromaeo_dom']}, 21:59:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:59:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:59:08 INFO - 'tests': ['basic_compositor_video']}, 21:59:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:59:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:59:08 INFO - 'tests': ['a11yr', 21:59:08 INFO - 'ts_paint', 21:59:08 INFO - 'tpaint', 21:59:08 INFO - 'sessionrestore', 21:59:08 INFO - 'sessionrestore_no_auto_restore', 21:59:08 INFO - 'tabpaint']}, 21:59:08 INFO - 'other-e10s': {'tests': ['a11yr', 21:59:08 INFO - 'ts_paint', 21:59:08 INFO - 'tpaint', 21:59:08 INFO - 'sessionrestore', 21:59:08 INFO - 'sessionrestore_no_auto_restore', 21:59:08 INFO - 'tabpaint']}, 21:59:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:59:08 INFO - 'ts_paint', 21:59:08 INFO - 'tpaint', 21:59:08 INFO - 'sessionrestore', 21:59:08 INFO - 'sessionrestore_no_auto_restore', 21:59:08 INFO - 'tabpaint']}, 21:59:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:59:08 INFO - 'ts_paint', 21:59:08 INFO - 'tpaint', 21:59:08 INFO - 'sessionrestore', 21:59:08 INFO - 'sessionrestore_no_auto_restore', 21:59:08 INFO - 'tabpaint']}, 21:59:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:59:08 INFO - 'tests': ['a11yr', 21:59:08 INFO - 'ts_paint', 21:59:08 INFO - 'tpaint', 21:59:08 INFO - 'sessionrestore', 21:59:08 INFO - 'sessionrestore_no_auto_restore', 21:59:08 INFO - 'tabpaint']}, 21:59:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:59:08 INFO - 'tests': ['a11yr', 21:59:08 INFO - 'ts_paint', 21:59:08 INFO - 'tpaint', 21:59:08 INFO - 'sessionrestore', 21:59:08 INFO - 'sessionrestore_no_auto_restore', 21:59:08 INFO - 'tabpaint']}, 21:59:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:59:08 INFO - 'tests': ['tsvgx', 21:59:08 INFO - 'tsvgr_opacity', 21:59:08 INFO - 'tart', 21:59:08 INFO - 'tscrollx', 21:59:08 INFO - 'cart', 21:59:08 INFO - 'tsvg_static']}, 21:59:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:59:08 INFO - 'tsvgr_opacity', 21:59:08 INFO - 'tart', 21:59:08 INFO - 'tscrollx', 21:59:08 INFO - 'cart', 21:59:08 INFO - 'tsvg_static']}, 21:59:08 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 21:59:08 INFO - 'talos_options': ['--disable-e10s'], 21:59:08 INFO - 'tests': ['tp5o']}, 21:59:08 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 21:59:08 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 21:59:08 INFO - 'talos_options': ['--disable-e10s', 21:59:08 INFO - '--xperf_path', 21:59:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:59:08 INFO - 'tests': ['tp5n']}, 21:59:08 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 21:59:08 INFO - 'talos_options': ['--xperf_path', 21:59:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:59:08 INFO - 'tests': ['tp5n']}}, 21:59:08 INFO - 'talos.zip': {'path': '', 21:59:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:59:08 INFO - Running post-action listener: _resource_record_post_action 21:59:08 INFO - [mozharness: 2016-12-21 05:59:08.798669Z] Finished populate-webroot step (success) 21:59:08 INFO - [mozharness: 2016-12-21 05:59:08.798802Z] Running create-virtualenv step. 21:59:08 INFO - Running pre-action listener: _resource_record_pre_action 21:59:08 INFO - Running main action method: create_virtualenv 21:59:08 INFO - Creating virtualenv /builds/slave/test/build/venv 21:59:08 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 21:59:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:59:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:59:08 INFO - Using real prefix '/tools/python27' 21:59:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:59:09 INFO - Installing distribute.............................................................................................................................................................................................done. 21:59:12 INFO - Installing pip.................done. 21:59:12 INFO - Return code: 0 21:59:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:59:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:59:12 INFO - Reading from file tmpfile_stdout 21:59:12 INFO - Output received: 21:59:12 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) 21:59:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:59:12 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')]} 21:59:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:12 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')]} 21:59:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:12 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 0x101becb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bef768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed3bcc9dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019cad30>, '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 0x1018f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1019bfbe8>, '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.qa0W2EkVgN/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.9XdGcrC4mF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 21:59:12 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 21:59:12 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 21:59:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qa0W2EkVgN/Render', 21:59:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:59:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:59:12 INFO - 'HOME': '/Users/cltbld', 21:59:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:59:12 INFO - 'LOGNAME': 'cltbld', 21:59:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:12 INFO - 'MOZ_NO_REMOTE': '1', 21:59:12 INFO - 'NO_EM_RESTART': '1', 21:59:12 INFO - 'PAGER': '/bin/cat', 21:59:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:59:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:12 INFO - 'PWD': '/builds/slave/test', 21:59:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:59:12 INFO - 'SHELL': '/bin/bash', 21:59:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9XdGcrC4mF/Listeners', 21:59:12 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 21:59:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:59:12 INFO - 'USER': 'cltbld', 21:59:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:59:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:59:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:12 INFO - 'XPC_FLAGS': '0x0', 21:59:12 INFO - 'XPC_SERVICE_NAME': '0', 21:59:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:59:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:13 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 21:59:13 INFO - Cleaning up... 21:59:13 INFO - Return code: 0 21:59:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:59:13 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')]} 21:59:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:13 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')]} 21:59:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:13 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 0x101becb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bef768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed3bcc9dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019cad30>, '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 0x1018f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1019bfbe8>, '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.qa0W2EkVgN/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.9XdGcrC4mF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 21:59:13 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 21:59:13 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 21:59:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qa0W2EkVgN/Render', 21:59:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:59:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:59:13 INFO - 'HOME': '/Users/cltbld', 21:59:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:59:13 INFO - 'LOGNAME': 'cltbld', 21:59:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:13 INFO - 'MOZ_NO_REMOTE': '1', 21:59:13 INFO - 'NO_EM_RESTART': '1', 21:59:13 INFO - 'PAGER': '/bin/cat', 21:59:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:59:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:13 INFO - 'PWD': '/builds/slave/test', 21:59:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:59:13 INFO - 'SHELL': '/bin/bash', 21:59:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9XdGcrC4mF/Listeners', 21:59:13 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 21:59:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:59:13 INFO - 'USER': 'cltbld', 21:59:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:59:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:59:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:13 INFO - 'XPC_FLAGS': '0x0', 21:59:13 INFO - 'XPC_SERVICE_NAME': '0', 21:59:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:59:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:13 INFO - Downloading/unpacking psutil>=3.1.1 21:59:13 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 21:59:13 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 21:59:13 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 21:59:13 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 21:59:13 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 21:59:13 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 21:59:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:59:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:59:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:59:16 INFO - Installing collected packages: psutil 21:59:16 INFO - Running setup.py install for psutil 21:59:16 INFO - building 'psutil._psutil_osx' extension 21:59:16 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 21:59:17 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 21:59:17 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 21:59:17 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 21:59:17 INFO - building 'psutil._psutil_posix' extension 21:59:17 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 21:59:17 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:59:17 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:59:17 INFO - ^ 21:59:17 INFO - 1 warning generated. 21:59:17 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 21:59:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:59:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:59:17 INFO - Successfully installed psutil 21:59:17 INFO - Cleaning up... 21:59:17 INFO - Return code: 0 21:59:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:59:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:59:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:59:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:17 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 0x101becb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bef768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed3bcc9dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019cad30>, '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 0x1018f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1019bfbe8>, '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.qa0W2EkVgN/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.9XdGcrC4mF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 21:59:17 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 21:59:17 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 21:59:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qa0W2EkVgN/Render', 21:59:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:59:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:59:17 INFO - 'HOME': '/Users/cltbld', 21:59:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:59:17 INFO - 'LOGNAME': 'cltbld', 21:59:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:17 INFO - 'MOZ_NO_REMOTE': '1', 21:59:17 INFO - 'NO_EM_RESTART': '1', 21:59:17 INFO - 'PAGER': '/bin/cat', 21:59:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:59:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:17 INFO - 'PWD': '/builds/slave/test', 21:59:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:59:17 INFO - 'SHELL': '/bin/bash', 21:59:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9XdGcrC4mF/Listeners', 21:59:17 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 21:59:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:59:17 INFO - 'USER': 'cltbld', 21:59:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:59:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:59:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:17 INFO - 'XPC_FLAGS': '0x0', 21:59:17 INFO - 'XPC_SERVICE_NAME': '0', 21:59:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:59:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:59:18 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 21:59:18 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 21:59:18 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 21:59:18 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 21:59:18 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 21:59:18 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 21:59:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:59:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:59:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:59:20 INFO - Installing collected packages: mozsystemmonitor 21:59:20 INFO - Running setup.py install for mozsystemmonitor 21:59:21 INFO - Successfully installed mozsystemmonitor 21:59:21 INFO - Cleaning up... 21:59:21 INFO - Return code: 0 21:59:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:59:21 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')]} 21:59:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:21 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')]} 21:59:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:21 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 0x101becb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bef768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed3bcc9dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019cad30>, '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 0x1018f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1019bfbe8>, '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.qa0W2EkVgN/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.9XdGcrC4mF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 21:59:21 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 21:59:21 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 21:59:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qa0W2EkVgN/Render', 21:59:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:59:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:59:21 INFO - 'HOME': '/Users/cltbld', 21:59:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:59:21 INFO - 'LOGNAME': 'cltbld', 21:59:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:21 INFO - 'MOZ_NO_REMOTE': '1', 21:59:21 INFO - 'NO_EM_RESTART': '1', 21:59:21 INFO - 'PAGER': '/bin/cat', 21:59:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:59:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:21 INFO - 'PWD': '/builds/slave/test', 21:59:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:59:21 INFO - 'SHELL': '/bin/bash', 21:59:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9XdGcrC4mF/Listeners', 21:59:21 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 21:59:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:59:21 INFO - 'USER': 'cltbld', 21:59:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:59:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:59:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:21 INFO - 'XPC_FLAGS': '0x0', 21:59:21 INFO - 'XPC_SERVICE_NAME': '0', 21:59:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:59:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:21 INFO - Downloading/unpacking jsonschema==2.5.1 21:59:21 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 21:59:21 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 21:59:21 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 21:59:21 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 21:59:21 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 21:59:21 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 21:59:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:59:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:24 INFO - Downloading functools32-3.2.3-2.tar.gz 21:59:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:59:24 INFO - warning: no files found matching '*.txt' 21:59:24 INFO - no previously-included directories found matching 'build' 21:59:24 INFO - no previously-included directories found matching 'dist' 21:59:24 INFO - no previously-included directories found matching '.git*' 21:59:24 INFO - Installing collected packages: jsonschema, functools32 21:59:24 INFO - Running setup.py install for functools32 21:59:24 INFO - warning: no files found matching '*.txt' 21:59:24 INFO - no previously-included directories found matching 'build' 21:59:24 INFO - no previously-included directories found matching 'dist' 21:59:24 INFO - no previously-included directories found matching '.git*' 21:59:24 INFO - Successfully installed jsonschema functools32 21:59:24 INFO - Cleaning up... 21:59:24 INFO - Return code: 0 21:59:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:59:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:59:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101becb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bef768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed3bcc9dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019cad30>, '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 0x1018f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1019bfbe8>, '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.qa0W2EkVgN/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.9XdGcrC4mF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 21:59:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:59:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:59:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qa0W2EkVgN/Render', 21:59:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:59:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:59:24 INFO - 'HOME': '/Users/cltbld', 21:59:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:59:24 INFO - 'LOGNAME': 'cltbld', 21:59:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:24 INFO - 'MOZ_NO_REMOTE': '1', 21:59:24 INFO - 'NO_EM_RESTART': '1', 21:59:24 INFO - 'PAGER': '/bin/cat', 21:59:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:59:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:24 INFO - 'PWD': '/builds/slave/test', 21:59:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:59:24 INFO - 'SHELL': '/bin/bash', 21:59:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9XdGcrC4mF/Listeners', 21:59:24 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 21:59:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:59:24 INFO - 'USER': 'cltbld', 21:59:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:59:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:59:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:24 INFO - 'XPC_FLAGS': '0x0', 21:59:24 INFO - 'XPC_SERVICE_NAME': '0', 21:59:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:59:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:59:25 INFO - Cleaning up... 21:59:25 INFO - Return code: 0 21:59:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:59:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:59:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:59:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:25 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 0x101becb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bef768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed3bcc9dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019cad30>, '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 0x1018f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1019bfbe8>, '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.qa0W2EkVgN/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.9XdGcrC4mF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 21:59:25 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 21:59:25 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 21:59:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qa0W2EkVgN/Render', 21:59:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:59:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:59:25 INFO - 'HOME': '/Users/cltbld', 21:59:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:59:25 INFO - 'LOGNAME': 'cltbld', 21:59:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:25 INFO - 'MOZ_NO_REMOTE': '1', 21:59:25 INFO - 'NO_EM_RESTART': '1', 21:59:25 INFO - 'PAGER': '/bin/cat', 21:59:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:59:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:25 INFO - 'PWD': '/builds/slave/test', 21:59:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:59:25 INFO - 'SHELL': '/bin/bash', 21:59:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9XdGcrC4mF/Listeners', 21:59:25 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 21:59:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:59:25 INFO - 'USER': 'cltbld', 21:59:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:59:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:59:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:25 INFO - 'XPC_FLAGS': '0x0', 21:59:25 INFO - 'XPC_SERVICE_NAME': '0', 21:59:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:59:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:25 INFO - Downloading/unpacking blobuploader==1.2.4 21:59:25 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 21:59:25 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 21:59:25 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 21:59:25 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 21:59:25 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 21:59:25 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 21:59:28 INFO - Downloading blobuploader-1.2.4.tar.gz 21:59:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:59:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:59:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:59:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:59:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:29 INFO - Downloading docopt-0.6.1.tar.gz 21:59:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:59:29 INFO - Installing collected packages: blobuploader, requests, docopt 21:59:29 INFO - Running setup.py install for blobuploader 21:59:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:59:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:59:29 INFO - Running setup.py install for requests 21:59:30 INFO - Running setup.py install for docopt 21:59:30 INFO - Successfully installed blobuploader requests docopt 21:59:30 INFO - Cleaning up... 21:59:30 INFO - Return code: 0 21:59:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:59: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')]} 21:59:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59: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')]} 21:59:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:31 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 0x101becb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bef768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed3bcc9dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019cad30>, '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 0x1018f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1019bfbe8>, '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.qa0W2EkVgN/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.9XdGcrC4mF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 21:59:31 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 21:59:31 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 21:59:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qa0W2EkVgN/Render', 21:59:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:59:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:59:31 INFO - 'HOME': '/Users/cltbld', 21:59:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:59:31 INFO - 'LOGNAME': 'cltbld', 21:59:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:31 INFO - 'MOZ_NO_REMOTE': '1', 21:59:31 INFO - 'NO_EM_RESTART': '1', 21:59:31 INFO - 'PAGER': '/bin/cat', 21:59:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:59:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:31 INFO - 'PWD': '/builds/slave/test', 21:59:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:59:31 INFO - 'SHELL': '/bin/bash', 21:59:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9XdGcrC4mF/Listeners', 21:59:31 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 21:59:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:59:31 INFO - 'USER': 'cltbld', 21:59:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:59:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:59:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:31 INFO - 'XPC_FLAGS': '0x0', 21:59:31 INFO - 'XPC_SERVICE_NAME': '0', 21:59:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:59:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:59:31 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-5X53Kh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:59:31 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-OQH8n6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:59:31 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-SVb27D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:59:31 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-sKOHsZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:59:31 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-83EPBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:59:31 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-pbubbL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:59:31 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-1uHR0o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:59:32 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-rDfJLl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:59:32 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-lQBdJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:59:32 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-9_92i2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:59:32 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-Z8UHqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:59:32 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-KKdjA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:59:32 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-2c8NNH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:59:32 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-9xZWan-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:59:32 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-ai1N90-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:59:32 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-9kY9JH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:59:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:59:33 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-uwQN9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:59:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:59:33 INFO - Running setup.py install for manifestparser 21:59:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:59:33 INFO - Running setup.py install for mozcrash 21:59:33 INFO - Running setup.py install for mozdebug 21:59:33 INFO - Running setup.py install for mozdevice 21:59:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:59:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:59:33 INFO - Running setup.py install for mozfile 21:59:33 INFO - Running setup.py install for mozhttpd 21:59:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:59:34 INFO - Running setup.py install for mozinfo 21:59:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:59:34 INFO - Running setup.py install for mozInstall 21:59:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:59:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:59:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:59:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:59:34 INFO - Running setup.py install for mozleak 21:59:34 INFO - Running setup.py install for mozlog 21:59:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:59:34 INFO - Running setup.py install for moznetwork 21:59:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:59:34 INFO - Running setup.py install for mozprocess 21:59:34 INFO - Running setup.py install for mozprofile 21:59:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:59:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:59:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:59:35 INFO - Running setup.py install for mozrunner 21:59:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:59:35 INFO - Running setup.py install for mozscreenshot 21:59:35 INFO - Running setup.py install for moztest 21:59:35 INFO - Running setup.py install for mozversion 21:59:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:59:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:59:35 INFO - Cleaning up... 21:59:35 INFO - Return code: 0 21:59:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:59: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')]} 21:59:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59: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')]} 21:59:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:36 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 0x101becb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bef768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed3bcc9dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019cad30>, '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 0x1018f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1019bfbe8>, '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.qa0W2EkVgN/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.9XdGcrC4mF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 21:59:36 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 21:59:36 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 21:59:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qa0W2EkVgN/Render', 21:59:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:59:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:59:36 INFO - 'HOME': '/Users/cltbld', 21:59:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:59:36 INFO - 'LOGNAME': 'cltbld', 21:59:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:36 INFO - 'MOZ_NO_REMOTE': '1', 21:59:36 INFO - 'NO_EM_RESTART': '1', 21:59:36 INFO - 'PAGER': '/bin/cat', 21:59:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:59:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:36 INFO - 'PWD': '/builds/slave/test', 21:59:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:59:36 INFO - 'SHELL': '/bin/bash', 21:59:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9XdGcrC4mF/Listeners', 21:59:36 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 21:59:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:59:36 INFO - 'USER': 'cltbld', 21:59:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:59:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:59:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:36 INFO - 'XPC_FLAGS': '0x0', 21:59:36 INFO - 'XPC_SERVICE_NAME': '0', 21:59:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:59:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:59:36 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-Xvhuma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:59:36 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)) 21:59:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:59:36 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-FJYKHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:59:36 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)) 21:59:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:59:36 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-xkBrYR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:59:36 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)) 21:59:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:59:36 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-_cR58c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:59:36 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)) 21:59:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:59:36 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-bQ9HOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:59:36 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)) 21:59:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:59:36 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-J9qPfI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:59:37 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)) 21:59:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:59:37 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-PaVEdD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:59:37 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)) 21:59:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:59:37 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-itYhkN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:59:37 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)) 21:59:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:59:37 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-N7AwAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:59:37 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)) 21:59:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:59:37 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-zopzem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:59:37 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)) 21:59:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:59:37 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-u5Ui1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:59:37 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)) 21:59:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:59:37 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-AVIsml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:59:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 21:59:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:59:37 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-SUjgKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:59:37 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)) 21:59:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:59:37 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-ZUrLKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:59:37 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)) 21:59:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:59:37 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-EqODnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:59:38 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)) 21:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:59:38 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-II5QxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:59:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 21:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:59:38 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-3el5Vs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:59:38 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)) 21:59:38 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)) 21:59:38 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)) 21:59:38 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)) 21:59:38 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)) 21:59:38 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)) 21:59:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:59:38 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 21:59:38 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 21:59:38 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 21:59:38 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 21:59:38 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 21:59:38 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 21:59:41 INFO - Downloading blessings-1.6.tar.gz 21:59:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:59:41 INFO - Installing collected packages: blessings 21:59:41 INFO - Running setup.py install for blessings 21:59:41 INFO - Successfully installed blessings 21:59:41 INFO - Cleaning up... 21:59:41 INFO - Return code: 0 21:59:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:59:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:59:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:59:41 INFO - Reading from file tmpfile_stdout 21:59:41 INFO - Current package versions: 21:59:41 INFO - blessings == 1.6 21:59:41 INFO - blobuploader == 1.2.4 21:59:41 INFO - docopt == 0.6.1 21:59:41 INFO - functools32 == 3.2.3-2 21:59:41 INFO - jsonschema == 2.5.1 21:59:41 INFO - manifestparser == 1.1 21:59:41 INFO - mozInstall == 1.12 21:59:41 INFO - mozcrash == 1.0 21:59:41 INFO - mozdebug == 0.1 21:59:41 INFO - mozdevice == 0.49 21:59:41 INFO - mozfile == 1.2 21:59:41 INFO - mozhttpd == 0.7 21:59:41 INFO - mozinfo == 0.9 21:59:41 INFO - mozleak == 0.1 21:59:41 INFO - mozlog == 3.4 21:59:41 INFO - moznetwork == 0.27 21:59:41 INFO - mozprocess == 0.23 21:59:41 INFO - mozprofile == 0.28 21:59:41 INFO - mozrunner == 6.13 21:59:41 INFO - mozscreenshot == 0.1 21:59:41 INFO - mozsystemmonitor == 0.3 21:59:41 INFO - moztest == 0.7 21:59:41 INFO - mozversion == 1.4 21:59:41 INFO - psutil == 3.1.1 21:59:41 INFO - requests == 1.2.3 21:59:41 INFO - wsgiref == 0.1.2 21:59:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:59:41 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')]} 21:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:41 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')]} 21:59:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:41 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 0x101becb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bef768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed3bcc9dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019cad30>, '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 0x1018f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1019bfbe8>, '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.qa0W2EkVgN/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.9XdGcrC4mF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 21:59:41 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 21:59:41 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 21:59:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qa0W2EkVgN/Render', 21:59:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:59:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:59:41 INFO - 'HOME': '/Users/cltbld', 21:59:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:59:41 INFO - 'LOGNAME': 'cltbld', 21:59:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:41 INFO - 'MOZ_NO_REMOTE': '1', 21:59:41 INFO - 'NO_EM_RESTART': '1', 21:59:41 INFO - 'PAGER': '/bin/cat', 21:59:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:59:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:41 INFO - 'PWD': '/builds/slave/test', 21:59:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:59:41 INFO - 'SHELL': '/bin/bash', 21:59:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9XdGcrC4mF/Listeners', 21:59:41 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 21:59:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:59:41 INFO - 'USER': 'cltbld', 21:59:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:59:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:59:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:41 INFO - 'XPC_FLAGS': '0x0', 21:59:41 INFO - 'XPC_SERVICE_NAME': '0', 21:59:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:59:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:42 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)) 21:59:42 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)) 21:59:42 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)) 21:59:42 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)) 21:59:42 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)) 21:59:42 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)) 21:59:42 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)) 21:59:42 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)) 21:59:42 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)) 21:59:42 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)) 21:59:42 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)) 21:59:42 INFO - Cleaning up... 21:59:42 INFO - Return code: 0 21:59:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:59: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')]} 21:59:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59: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')]} 21:59:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101becb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bef768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed3bcc9dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019cad30>, '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 0x1018f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1019bfbe8>, '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.qa0W2EkVgN/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.9XdGcrC4mF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 21:59: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', 'jsonschema'] in /builds/slave/test/build 21:59: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 jsonschema 21:59:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qa0W2EkVgN/Render', 21:59:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:59:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:59:42 INFO - 'HOME': '/Users/cltbld', 21:59:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:59:42 INFO - 'LOGNAME': 'cltbld', 21:59:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:42 INFO - 'MOZ_NO_REMOTE': '1', 21:59:42 INFO - 'NO_EM_RESTART': '1', 21:59:42 INFO - 'PAGER': '/bin/cat', 21:59:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:59:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:42 INFO - 'PWD': '/builds/slave/test', 21:59:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:59:42 INFO - 'SHELL': '/bin/bash', 21:59:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9XdGcrC4mF/Listeners', 21:59:42 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 21:59:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:59:42 INFO - 'USER': 'cltbld', 21:59:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:59:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:59:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:42 INFO - 'XPC_FLAGS': '0x0', 21:59:42 INFO - 'XPC_SERVICE_NAME': '0', 21:59:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:59:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:59:42 INFO - Cleaning up... 21:59:42 INFO - Return code: 0 21:59:42 INFO - Running post-action listener: _resource_record_post_action 21:59:42 INFO - Running post-action listener: _start_resource_monitoring 21:59:42 INFO - Starting resource monitoring. 21:59:42 INFO - [mozharness: 2016-12-21 05:59:42.459313Z] Finished create-virtualenv step (success) 21:59:42 INFO - [mozharness: 2016-12-21 05:59:42.460287Z] Running install step. 21:59:42 INFO - Running pre-action listener: _resource_record_pre_action 21:59:42 INFO - Running main action method: install 21:59:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:59:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:59:42 INFO - Reading from file tmpfile_stdout 21:59:42 INFO - Detecting whether we're running mozinstall >=1.0... 21:59:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:59:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:59:42 INFO - Reading from file tmpfile_stdout 21:59:42 INFO - Output received: 21:59:42 INFO - Usage: mozinstall [options] installer 21:59:42 INFO - Options: 21:59:42 INFO - -h, --help show this help message and exit 21:59:42 INFO - -d DEST, --destination=DEST 21:59:42 INFO - Directory to install application into. [default: 21:59:42 INFO - "/builds/slave/test"] 21:59:42 INFO - --app=APP Application being installed. [default: firefox] 21:59:42 INFO - mkdir: /builds/slave/test/build/application 21:59:42 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'] 21:59:42 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 22:00:05 INFO - Reading from file tmpfile_stdout 22:00:05 INFO - Output received: 22:00:05 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 22:00:05 INFO - Running post-action listener: _resource_record_post_action 22:00:05 INFO - [mozharness: 2016-12-21 06:00:05.222521Z] Finished install step (success) 22:00:05 INFO - [mozharness: 2016-12-21 06:00:05.222672Z] Running run-tests step. 22:00:05 INFO - Running pre-action listener: _resource_record_pre_action 22:00:05 INFO - Running main action method: run_tests 22:00:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:00:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:00:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:00:05 INFO - 2016-12-20 22:00:05.237 screenresolution[1629:7427] starting screenresolution argv=screenresolution get 22:00:05 INFO - 2016-12-20 22:00:05.240 screenresolution[1629:7427] Display 0: 1600x1200x32@60 22:00:05 INFO - 2016-12-20 22:00:05.245 screenresolution[1630:7429] starting screenresolution argv=screenresolution list 22:00:05 INFO - Available Modes on Display 0 22:00:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:00:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:00:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:00:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:00:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:00:05 INFO - Intel Iris: 22:00:05 INFO - Chipset Model: Intel Iris 22:00:05 INFO - Type: GPU 22:00:05 INFO - Bus: Built-In 22:00:05 INFO - VRAM (Dynamic, Max): 1536 MB 22:00:05 INFO - Vendor: Intel (0x8086) 22:00:05 INFO - Device ID: 0x0a2e 22:00:05 INFO - Revision ID: 0x0009 22:00:05 INFO - Displays: 22:00:05 INFO - Display: 22:00:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:00:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:00:05 INFO - Display Serial Number: 1600x1200 60 22:00:05 INFO - Main Display: Yes 22:00:05 INFO - Mirror: Off 22:00:05 INFO - Online: Yes 22:00:05 INFO - Rotation: Supported 22:00:05 INFO - Return code: 0 22:00:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:00:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:00:05 INFO - Python 2.7.3 22:00:05 INFO - Return code: 0 22:00:05 INFO - grabbing minidump binary from tooltool 22:00:05 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')]} 22:00:05 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 0x1019cad30>, '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 0x1018f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1019bfbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:00:05 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 22:00:05 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 22:00:05 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 22:00:05 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:00:05 INFO - Return code: 0 22:00:05 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 22:00:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:00:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:00:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 22:00:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:00:05 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/DkyMu6TySlmVLmQyzgcaQg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0264', '--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 22:00:05 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/DkyMu6TySlmVLmQyzgcaQg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0264 --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 22:00:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qa0W2EkVgN/Render', 22:00:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:00:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:00:05 INFO - 'HOME': '/Users/cltbld', 22:00:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:00:05 INFO - 'LOGNAME': 'cltbld', 22:00:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:00:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 22:00:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:05 INFO - 'MOZ_NO_REMOTE': '1', 22:00:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:00:05 INFO - 'NO_EM_RESTART': '1', 22:00:05 INFO - 'PAGER': '/bin/cat', 22:00:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:00:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:05 INFO - 'PWD': '/builds/slave/test', 22:00:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:00:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:00:05 INFO - 'SHELL': '/bin/bash', 22:00:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9XdGcrC4mF/Listeners', 22:00:05 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 22:00:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:00:05 INFO - 'USER': 'cltbld', 22:00:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:00:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:00:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:05 INFO - 'XPC_FLAGS': '0x0', 22:00:05 INFO - 'XPC_SERVICE_NAME': '0', 22:00:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:00:05 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/DkyMu6TySlmVLmQyzgcaQg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0264', '--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 22:00:05 INFO - mozversion application_buildid: 20161220201353 22:00:05 INFO - mozversion application_changeset: 20774bffb62a3c1fecf98ed8ad9ee1a861bcd9b7 22:00:05 INFO - mozversion application_display_name: Nightly 22:00:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:00:05 INFO - mozversion application_name: Firefox 22:00:05 INFO - mozversion application_remotingname: firefox 22:00:05 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 22:00:05 INFO - mozversion application_vendor: Mozilla 22:00:05 INFO - mozversion application_version: 53.0a1 22:00:05 INFO - mozversion platform_buildid: 20161220201353 22:00:05 INFO - mozversion platform_changeset: 20774bffb62a3c1fecf98ed8ad9ee1a861bcd9b7 22:00:05 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 22:00:05 INFO - mozversion platform_version: 53.0a1 22:00:05 INFO - using testdate: 1482300005 22:00:05 INFO - actual date: 1482300005 22:00:05 INFO - starting webserver on 'localhost:49236' 22:00:05 INFO - SUITE-START | Running 2 tests 22:00:05 INFO - TEST-START | dromaeo_css 22:00:05 INFO - operating with platform_type : mac_ 22:00:05 INFO - Initialising browser for dromaeo_css test... 22:00:05 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/tmpUDblF5/profile http://localhost:49236/getInfo.html) 22:00:08 INFO - PROCESS | 1640 | __metrics Screen width/height:1600/1200 22:00:08 INFO - PROCESS | 1640 | colorDepth:24 22:00:08 INFO - PROCESS | 1640 | Browser inner width/height: 1024/689 22:00:08 INFO - PROCESS | 1640 | __metrics 22:00:08 INFO - PROCESS | 1640 | 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" 22:00:08 INFO - PROCESS | 1640 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:00:09 INFO - TEST-INFO | 1640: exit 0 22:00:09 INFO - Browser initialized. 22:00:09 INFO - Running cycle 1/1 for dromaeo_css test... 22:00:09 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/tmpUDblF5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:00:21 INFO - PROCESS | 1642 | RSS: Main: 237043712 22:00:21 INFO - PROCESS | 1642 | 22:01:12 INFO - PROCESS | 1642 | 1482300072249 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 22:03:25 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 22:03:27 INFO - PROCESS | 1642 | RSS: Main: 379019264 22:03:27 INFO - PROCESS | 1642 | 22:06:30 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 22:06:31 INFO - PROCESS | 1642 | RSS: Main: 381001728 22:06:31 INFO - PROCESS | 1642 | 22:09:34 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 22:09:34 INFO - PROCESS | 1642 | RSS: Main: 341995520 22:09:34 INFO - PROCESS | 1642 | 22:12:37 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 22:12:37 INFO - PROCESS | 1642 | RSS: Main: 339537920 22:12:37 INFO - PROCESS | 1642 | 22:15:41 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 22:15:42 INFO - PROCESS | 1642 | RSS: Main: 334204928 22:15:42 INFO - PROCESS | 1642 | 22:18:45 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 22:18:45 INFO - PROCESS | 1642 | RSS: Main: 410804224 22:18:45 INFO - PROCESS | 1642 | 22:18:45 INFO - PROCESS | 1642 | __start_tp_report 22:18:45 INFO - PROCESS | 1642 | _x_x_mozilla_page_load 22:18:45 INFO - PROCESS | 1642 | _x_x_mozilla_page_load_details 22:18:45 INFO - PROCESS | 1642 | |i|pagename|runs| 22:18:45 INFO - PROCESS | 1642 | |0;dojo.html;3333.416652085885;3350.916227094323;3358.076528954537;3368.208471009314;3409.2840503494267;5533.750981205845;5623.746931388087;5632.380438151805;5719.656820590768;5732.2261494698205;5612.438756124386;5629.6340737852115;5686.402927692585;5708.828735137942;5723.055695810197;5082.390113186423;5123.7438128093445;5127.051495473331;5188.143956247215;5206.7656955436905;5232.764525596338;5349.759260833272;5354;5364.302640656709;5408.296921400212;5127.846164615067;5299.231611416361;5334.03987282289;5353;5397.379301380352;4532.116237333721;4950.950490495121;5168.741562921877;5207.765650545697;5234.738263086869;5188.92216616751;5193.143131383317;5219.5041471060185;5220.817271395483;5243.895122097575;5687.744051517691;5700.828975130753;5725.08398656213;5733.713314334266;5760.942390576124;5943.286805583358;5956.851078723023;5970.223870896755;6157.969210153965;6243.219597550306;6225.346338634424;6293.748250069992;6302.46429053531;6303.086052522359;6332.1135041094285;5780.3063632363965;5804.2744656917885;5812.011957967071;5815.360310365856;5864.999999999957;5890.028145355968;6215.595986260879;6247.781327653511;6295.24457065146;6298.464630506458;4793.352897358882;6074.54440916933;6099.9390006099375;6115.052166914135;6212.751489940351;6280.591761535486;6285.528585356116;6310.652914089677;6310.810675679737;6319.46284565817;6118.1128736332985;6244.000959846403;6249;6265.686715664198;6267.122602835607;6101.065651476929;6110.877782444326;6127.128444391265;6254.843628909222;6261.812145635638;4922.556969872729;4929.630277729113;4933.531314525115;4936.308916751657;4946.579540739078;4363.978180109079;4450.888727781831;4475.440569928759;4487.708298960557;4506.932396014063;5655.462731040545;5702.344230413555;5708.4862362387585;5711.057675483582;5738.68437235956;6244.375562443719;6295.37046295376;6297.748090076346;6306;6308.621482711052;5779.797707080316;5785.103308987113;5786.189933409326;5793.15999180125;5846.795362162304;5254.133068043807;5280.656757310762;5406.351237851404;5420.403755586883;5420.512153906167;5250.26496290512;6249.968750156311;6300.306966233619;6315.115883776183;6332.176817013758;6271.184745982993;6275.435210831047;6294.3076261612105;6302;6318.368163183645;5177.663451875616;6268.4671802897265;6318.652474113784;6334;6340.397662222082;6004.549658775697;6060.2424696912885;6103.786367477117;6131;6216.347283535345;6250.1874756281395;6279.937200627935;6288.339724328879;6289.182406287154;6300.527460440394;6022.909656355246;6111.877762444815;6135.877282454415;6159.630422174684;6160.291566469913;5007.674501157413;5519.613627046068;5909.261342332208;5973.910391344047;6084.11780291864;5904.734286957011;6011.519078473799;6012.669303188191;6059.787907423219;6071.089336599369;6132.877342453036;6153.538484613582;6171.259448866164;6183.690815459299;6184.6598437086395;5713.371529131875;5792.160136780228;5979.730912108878;5986.640801551921;6054.3642917493025 22:18:45 INFO - PROCESS | 1642 | |1;ext.html;422.65342419216233;469.97415142167165;492.2345752355088;495.41046155075435;502.10625087344516;24241.757582424172;32803.88363105507;37249.62750372499;37789.05527361817;39349.21301573974;39600;39879.401808972885;40375.15498140227;40453.393199102036;40467.392989105116;8336.541490218036;9142.725718228463;9346.252299815998;9348.859767103499;9354.438733676001;8410.78973025673;10878.129749620051;11179.329240245612;11186.44067796607;11366.71583210418;11127.108391573453;11186.161037922147;11202.943985280062;11204.439778011109;11265.549378024869;11086.722831929186;11151.944240278828;11164.995150436418;11179.552817887276;11180.993710566006;10974.561017559368;11070.28043177191;11071.003609675088;11072.667819965414;11084.944575277153;37908;38192.427113593316;38194.23611527782;38216.61783382158;38228.42657360142;3215.099772063826;3282.6881446262805;3459.187091033605;3480.512728218026;3656.981715091434;26306.73693263081;27815.58276625852;27816.86091569529;27887.581686274723;27888;3058.204866734665;3210.7431405487737;3253.6746325367276;3273.0998975281987;3274.4433446314183;456378;456478;457544;457994.9999999967;459181;52968.73515632397;53132;53273.46726532685;53425.46574534205;53526.73236633792;54124.963754711636;54301.1854822178;54336.72831635817;54430.727846361304;54461.72769136208;12035;14780.260986950609;15043.022203556733;15054;15135.772963405558;10514.264001519974;10768.569257229623;10774.892251077546;11387.487563059682;11429.657110286706;16380.49666007193;20434.591308173753;20533;20562.794372056087;21230.78769212319;7316.561006339637;8185.140560241208;8516.06323304436;8544.2310192083;8598.78503037429;857.4769390671685;935.5649622925372;938.136914039072;988.1452543549777;1021.0810270756378;27911.720882790913;29202.269943251587;29285.974990875642;29450.887867875324;29621.555676664866;993.1558175550724;1029.7528593137743;1032.731489812639;1040.1834559870465;1100.2188446203286;14296.785548216785;14778.704425911421;14791.482298119514;15186.924065379602;15196.392144314324;622920;626674;627491;628834;634265;55053.72473137689;55645;55773.721131394086;55818.72090639521;55845.88308233813;1232.279116716713;1281.653953432568;1343.536479914428;1389.1873254146235;1405.051590176647;24018.75981240165;26483.94064237486;29261.26846828761;30101.849490752407;30126.849365753907;45901.08197835958;46385.84035399142;46391.3041304374;46421;46444.7677761609;506723;508692;510127;511050;511104;24603.325368179987;24948.251552453454;25404.745952540237;25901.611475828253;26070;37811.81094094512;38458;38697.226055479296;39060.80469597634;39220.82337529879;33138.83430582831;33521.83239083789;33742.49386259257;33785.66214337825;33994.490082648284;32812.67187328096;33632;34012.31975360429;34189.658103418646;34535;32563.837180813945;33040.83479582587;33090;33094.66905330916;33144.668553315125;28489.43021139607;29813.850930745208;30081.69918300789;30231.69768302289;30616.92840750563;20144.489163312515;20873;22309.665355019362;22928.656070159293;23099.19152829643 22:18:45 INFO - PROCESS | 1642 | |2;jquery.html;354.06879905847615;371.4521081404926;373.85793398508565;381.49451976131616;402.88115006073207;14009.369578368973;14113.223772692498;14839.777403338945;18581.81418185818;19286.90356548219;11546.769064618702;11848.34834084125;12133.907948284652;19335.90332048338;20078;5101.15830887903;5160.483951604847;5161.799684195804;5326.934613077381;5346.27825243591;5087.516685914832;5256.579473642099;5264.315638966948;5265.157574788034;5269.051570717269;3791.298609757204;3987.5214974203136;5543;5801;5839.240898683165;5628;5871.471567558919;5880.97059514704;5881.117832325142;5898.879212949526;5597.860053498654;5677.630953987978;5688.776912963691;5703.600747947646;5705;13044.08691391603;13141.342932853318;23977.760222397726;26779;26999;2450.914218002379;2479.801615870726;2492.763187497185;2600.596907479344;2999.0552975812766;15778.684426311524;16777;16839.410620628343;16928.40750573724;17539.649207015787;1994.2521554417094;2000.5298754792611;2020.111151093514;2032.5223572460459;2046.3144846476448;87261.56369218176;130814.6918530812;133431;139300.60699392977;142328.28835855858;19336.4199074028;19848.90075549613;20054.59890802176;20756.792432075486;20785.376438706862;28019.579706304423;29493.852530737637;32745.836270818494;34578.135546611535;34682.65317346845;10202.38785672862;10584.523696433678;10665;10683.465826708634;10798.73003174927;8734.475931444134;8746.300295976307;8748.431351962103;8884.200421962054;8945.06076861933;7987.32107770846;9510.809783804423;9600.423974561549;9733.902660973441;9775.120239178508;3135.5139953307275;3638.87194969555;3742.1954279829965;3765.962340376616;3780.8298626561323;842.2419822159983;889.0798024045082;901.8917729872458;913.6893456224783;1043.3739756146251;19657.705134422995;20023;21010.054547545093;21062.052207650388;21085.566994949022;896.8296023755465;928.3872644054892;934.4626839567276;946.0633972367444;984.7193549838405;9193.862092068624;10310.432926188982;10632.627858025087;10968.725781855517;11081.667549973514;487083;516843.4157829187;517029;560968;565640;123815;127464;128127;128685.35657321653;131735.34132329276;975.059067999384;982.823091843475;1031.83490641497;1034.5189486888482;1034.5396298647029;18157.36449224271;18369.897806131674;18551.90724046371;18557.72163417523;18563.35028274004;36073.63926360703;51444.22833657573;51526;51625.741871290404;53830;64790;67759;69396;70285;72048.63975680088;5719.28508936383;7382.187959324363;7931.643076061707;7937.285644292041;8163.428560000743;11087;11907.404629768303;12317.568885089337;12354;12403.503859845505;9296.349255552317;9626.95186524063;9761.609535618496;9973.351732137387;10668.253222274367;10351.741206469898;10424.94787526088;10599.576016959236;10986.670399888017;11133.109351251718;10975.945120274348;11031.944840275748;11073.778524429628;11126;11143.275687080313;6791.66041697923;7733.92266077332;7822.569758663328;7931.920680793118;8049.87925181111;10589.205809564159;10690.732731681459;10958.780824383628;10979.51776510193;11049.39228342449 22:18:45 INFO - PROCESS | 1642 | |3;mootools.html;1430.356339647159;1478.9112653240804;1518.2332921874456;1829.4968883557028;1878.8496920246382;8063.59682015899;8507.829843403137;8515.191056849604;8522.275606573434;8523.78690532737;7430.925690743091;7702.152763196044;7731.574763388011;7987.600619969007;8241.83516329673;2271.2731925783755;2327.6857624220766;2330.3707998840305;2332.47519308156;2336.8597884127007;1955.5599990002206;2311.6763653088583;2323.942606114214;2331.7901388875;2341.4731685370825;2311.3181611424584;2319.675245465636;2347.4600841806396;2351.529694061186;2352.0121548949396;2258.943526411853;2273.6816845641624;2294.9311520654405;2319.512902290521;2325.837191396603;2286.3826766773045;2313.9305820825402;2315.7452680205165;2323.4307594639254;2367.0650093213085;8319.584020798935;8406.24343809054;8407.70573029947;8410.579471026424;8423.452475589067;5055.5702765265;5218.321618189649;5223.947760522422;5238.81664141757;5240.34495688039;3006.5790789289517;3268.346330733863;3362.7646064775477;3577.302426026926;3579.087332730137;1023.4575674892319;1035.9533820978074;1036.3833519056225;1040.8126537223297;1076.95692172313;10684;10897.618583349546;10931.398773067478;10934.343939363584;11028.50371733274;4320.243957307459;4513.480949690762;4538.205813982539;4648.86053418398;4654.16225079489;7693.230676932262;9121.179093881583;9170.541472926327;9183.540822958825;9209.76975575616;4397.340398940185;4411.404460397869;5055.823046193439;5125.743712814345;5229.843104706789;4244.490661120623;4414.955850441519;4416.094700586372;4718.764061796896;4779.259214821639;3221.8872339468007;3725.3480640887738;3744.194998075427;3864.7487913285545;3903.902402439962;1048.4705223861902;1049.2917280835406;1056.1550759392455;1056.3556230699267;1075.983860242097;837.6942416018231;848;857.5197889182078;913.5386629752065;917.0233701108299;4334.653227741836;5385.78456861729;5458.635341164709;5621.831345059655;5793.304803423616;794.8370584030259;938.8591711243369;943.6980166346704;962.5235508423375;1004.7538353103537;3521.7006554442646;3566.1262990566956;3630.49173115764;3726.32926073304;3748.887533374003;9817.950910245403;10046.04562566555;10155.136813370798;10190.490475476197;10205.03052210039;10143.847842282372;10148.289619726696;10158.441285729356;10164.847527287096;10165.085142337077;7405.407567394595;7813.68745250195;7946.324562412144;7948.887155798193;7963.8407231855035;5424.403315635356;5517.200005999028;5554.416786237387;5623.437656234508;5634.380218176079;7723.845523089394;9009.54952252398;9131.041240669634;9293.25653947669;9427.905720942703;9347.579358928728;9387.85918211241;9453.621855125717;9570.808583828424;9573.712788616353;6588;6812.523123381514;6987.965060174666;7001.789946301619;7214.819629509304;7841.764747057598;7941.722039728582;7947.403944704055;8002.9599852000365;8021.037475502977;6982.68577913985;7168.4265258780215;7173.928260717535;7241.746538871114;7295.051643286339;6974.68613912365;7017.508774385744;7024.5082844200415;7120.750773722895;7208.495405321577;6337.936620633919;6343.080253363144;6417.518686098655;6421.743130274736;6447.6131432114225;4486.820527179007;4511.210538155744;4552.840650577214;4609.354690343422;4706.458757242961;4575.633949284116;4613.1004454131125;4645.883852903705;4663.300504924153;4756.7145971241835 22:18:45 INFO - PROCESS | 1642 | |4;prototype.html;350.147391102665;361.53001098571866;366.4411772047629;372.07539264926635;373.210659455252;4395.857077159942;5060.41805192403;5215.930734199489;5336.279602253704;5389.4610538946135;4564.931526027104;5191.792328306863;5338.546223570991;5380.892382152364;5398.082326004579;3336.5328853960464;3435.2823588205897;3927.5286965564173;4139.275626765319;4142.502899652046;4209.452771139763;4222.387753775701;4223.070924396628;4248.299030659938;4249.426327445786;4194.769287689176;4198.496180458349;4213.51544572375;4225.915481690365;4240.342746874239;3520.507129001929;3975.542812576533;4108.91782164358;4129.648979836717;4347.60881515167;3041.5893854329825;3234.9029529113927;3421.853679017532;3648.7958973538935;3720.088578298334;4660.067986402733;4956.653034287601;5013.448520662724;5113.846584602468;5237.214417837316;4212.283911734982;4542.772861356919;4619.514950930171;4654.976725116387;4846;5145.614078944057;5589.301337332833;5626.690532020737;5633.746481408305;5662.37713851476;3742.3825068863603;4056.0468289951837;4062.3500239961463;4086.2849001424634;4088.0393107619684;4938;5157.607445989562;5445.591580631429;5925;5950.494207992283;3970.900727481778;4163.855614358607;4169.207850508394;4183.728057676241;4200.663946884242;3235.7934684909524;3868.8065596720053;4040.959590404117;4264.296391095497;4288.335308027261;4163.3130533462245;4252.362145678111;4411.735295882258;4506.819727210875;4842.830500932521;5437.211604317431;5616.2698849150165;5626.324841019022;5717.2281741965135;5725.914111288334;1091.2034215022918;1274.789659706138;1282.6596206963745;1289.4197611075053;1293.0237670558856;817.2603793566832;824.3775949158347;839.992009588484;869.443556124081;878.1262643669589;4776.9841666250295;4796.136695394793;4919.483454237254;5075.56857667095;5108.6168537359845;4920.458749537548;4984.962180633625;5111.827473323822;5546.611737178439;5556.527170518426;4433.849582952265;4725.834595789131;4839.942260337955;4987.326710894055;5003.324551185616;2508.8243822932586;2559.1938539360044;2655.668041494813;2897.391547774949;2963.555466679972;5341.916652505526;5644.774209031592;5746.339170995306;5853.443922827325;5937.643741375531;5393.325834270716;5533.972330138324;5681.454836131161;5729.255196824386;5756.229669566441;5854.414558544197;5925.185536870038;6131.448169664752;6135.631862088289;6153.4154255345675;4807.351007613927;5529.498149341431;5551.389347171888;5952.672603006876;5985.5810093294795;5322.840314790563;5741.827745167651;5821.214136091573;5874.706264686834;5889.911651325147;5649.164021693048;6007.605702777916;6016.616178278933;6023.939760602338;6059.757609695739;3799.404250214861;3848.6536211741077;3849.615038496128;3851.7111216659423;3868.7678739274606;5086.745662716923;5811.79658711943;5845.327787304344;5916.8640620471215;5924.74139223434;5104.719240441811;5393.786398060405;5670.432956704297;5680.835428737017;5749.425057494384;5130.358705161855;5677.176809362537;5686.545076393796;5699.316082070012;5737.368889422077;4877.3903262092235;5276.287701160294;5550.47270509301;5603.38362780102;5609.317204838614;4998.2502624606595;5012.398512178416;5644.576656750678;5670.92252472029;5698.515626171822;4672.439307283148;5516.420775818481;5557.166425036277;5571;5593.748281327432 22:18:45 INFO - PROCESS | 1642 | |5;yui.html;607.4472230270453;713.5148099292479;731.0715391452852;787.1420152034285;818.2890591169046;11699.941500292498;15000.39998400064;15618.062916225035;15869.841301586981;15914;13961.371738271777;14280.143191408522;14356.712865742678;14507.709845803078;14532.418703251857;855.3285670748463;878.6002368922125;882.1443200095897;882.7969566999594;884.2969838977996;692.6779047742799;712.010305675112;713.878640631094;877.3113106211625;884.9999500564353;895.476146454325;915.5925613102172;925.9583318750639;936.5410948635188;940.2008292951006;922.7324076017946;923.3398120343953;924.4869097650835;925.065683659502;927.601131513449;533.3439868961161;551.3714365623193;682.6450245872119;683.565935630873;684.3259389501337;13807.962248305457;14341.426342946374;14400.991930564865;14738.55784326472;14744.262786860721;11487.25332853362;14022.298885055809;14099.436022559084;14250.14499130045;14319.713605727931;10597.120369356931;10760.623378181805;10772.138228941665;10970.670879873536;10981.890181098166;3727.1613886875234;3792.829322680486;3852.6917846572487;3862.1696335287766;3864.787436690981;103416.44875326876;103664.96335036629;104588;105001.94998050075;105517.47241263745;10467;10771.030607245386;10859.402732849769;11073.778524429628;11131.332120072822;20661.89669051675;21988;22289.44276393103;22319.55360892773;22335.776642233694;7865.646045927947;7881.487703299267;7883.526988380716;7884.487508311941;7899.052113746272;4133.958660413417;4298.742075475419;4370.672199585044;4475.7985890635;4486.439195100613;3310.526815567098;3539.3629146753315;3594.281143771256;3604.1710406606626;3613.7831730096277;652.5432197461796;668.2548957911894;672.4418732452151;690.0752990992095;695.2734392559787;543.2530270877544;576.6828244465527;579.6753817861927;644.9516286278548;647.9643619600968;8888.64445422176;8935.508547029976;9020.684276050439;9204.263658907272;9280.535973201313;654.4142992022208;657.2769953051701;662.6951602263013;669.902864084705;678.9932100679029;3956.3076461619103;4245.80893859777;4522.796474158671;4559.635229181657;4563.452385713669;100517.65317237469;101399.47900781494;102302;104725.47637261765;105311.36721582022;89304.10695893088;89764.5511772437;91589;92175;93558;77147;81103.78344324957;81147;81842.18157818465;81851.59074204591;7029.507934444539;8666.340889372175;8776.692815751418;8861.468311901306;9038.186563209343;48087.03825923392;49516.75241623769;51698.93204271787;53143.73428132835;53660.46339536554;67632.6473470518;71275;71344;71380.92928606179;71665;11349.092072634005;11514.424278786195;11593.768124637629;11686.766264674488;11966.880331196577;12587.181833180814;12750.362481876055;12803.29581873006;12857.164284321489;13475.865241347854;11682.24065435744;11866.466009029442;11948.283103013848;11953.488139875124;12412.689682758004;11864.169508134348;11895.702607434883;11927;12119.818202727143;12392.75214495723;11799.292042477478;11877.821832672344;11879.82180267314;11949.522019119138;12147.149699520949;9909.900900991186;10046.387939136024;10433.426161561187;10459.372437653765;10505.212109092;9733.367331123454;10007.849882251627;10324.896751032695;10357.22320825926;10382 22:18:45 INFO - PROCESS | 1642 | __end_tp_report 22:18:45 INFO - PROCESS | 1642 | __start_cc_report 22:18:45 INFO - PROCESS | 1642 | _x_x_mozilla_cycle_collect,1601 22:18:45 INFO - PROCESS | 1642 | __end_cc_report 22:18:45 INFO - PROCESS | 1642 | __startTimestamp1482301125595__endTimestamp 22:18:45 INFO - PROCESS | 1642 | 22:18:45 INFO - PROCESS | 1642 | ------- Summary: start ------- 22:18:45 INFO - PROCESS | 1642 | Number of tests: 6 22:18:45 INFO - PROCESS | 1642 | 22:18:45 INFO - PROCESS | 1642 | [#0] dojo.html Cycles:165 Average:5716.11 Median:5890.03 stddev:645.41 (11.0%) stddev-sans-first:619.73 22:18:45 INFO - PROCESS | 1642 | Values: 3333.4 3350.9 3358.1 3368.2 3409.3 5533.8 5623.7 5632.4 5719.7 5732.2 5612.4 5629.6 5686.4 5708.8 5723.1 5082.4 5123.7 5127.1 5188.1 5206.8 5232.8 5349.8 5354.0 5364.3 5408.3 5127.8 5299.2 5334.0 5353.0 5397.4 4532.1 4951.0 5168.7 5207.8 5234.7 5188.9 5193.1 5219.5 5220.8 5243.9 5687.7 5700.8 5725.1 5733.7 5760.9 5943.3 5956.9 5970.2 6158.0 6243.2 6225.3 6293.7 6302.5 6303.1 6332.1 5780.3 5804.3 5812.0 5815.4 5865.0 5890.0 6215.6 6247.8 6295.2 6298.5 4793.4 6074.5 6099.9 6115.1 6212.8 6280.6 6285.5 6310.7 6310.8 6319.5 6118.1 6244.0 6249.0 6265.7 6267.1 6101.1 6110.9 6127.1 6254.8 6261.8 4922.6 4929.6 4933.5 4936.3 4946.6 4364.0 4450.9 4475.4 4487.7 4506.9 5655.5 5702.3 5708.5 5711.1 5738.7 6244.4 6295.4 6297.7 6306.0 6308.6 5779.8 5785.1 5786.2 5793.2 5846.8 5254.1 5280.7 5406.4 5420.4 5420.5 5250.3 6250.0 6300.3 6315.1 6332.2 6271.2 6275.4 6294.3 6302.0 6318.4 5177.7 6268.5 6318.7 6334.0 6340.4 6004.5 6060.2 6103.8 6131.0 6216.3 6250.2 6279.9 6288.3 6289.2 6300.5 6022.9 6111.9 6135.9 6159.6 6160.3 5007.7 5519.6 5909.3 5973.9 6084.1 5904.7 6011.5 6012.7 6059.8 6071.1 6132.9 6153.5 6171.3 6183.7 6184.7 5713.4 5792.2 5979.7 5986.6 6054.4 22:18:45 INFO - PROCESS | 1642 | 22:18:45 INFO - PROCESS | 1642 | [#1] ext.html Cycles:180 Average:65274.98 Median:33065.42 stddev:143401.36 (433.7%) stddev-sans-first:143720.97 22:18:45 INFO - PROCESS | 1642 | Values: 422.7 470.0 492.2 495.4 502.1 24241.8 32803.9 37249.6 37789.1 39349.2 39600.0 39879.4 40375.2 40453.4 40467.4 8336.5 9142.7 9346.3 9348.9 9354.4 8410.8 10878.1 11179.3 11186.4 11366.7 11127.1 11186.2 11202.9 11204.4 11265.5 11086.7 11151.9 11165.0 11179.6 11181.0 10974.6 11070.3 11071.0 11072.7 11084.9 37908.0 38192.4 38194.2 38216.6 38228.4 3215.1 3282.7 3459.2 3480.5 3657.0 26306.7 27815.6 27816.9 27887.6 27888.0 3058.2 3210.7 3253.7 3273.1 3274.4 456378.0 456478.0 457544.0 457995.0 459181.0 52968.7 53132.0 53273.5 53425.5 53526.7 54125.0 54301.2 54336.7 54430.7 54461.7 12035.0 14780.3 15043.0 15054.0 15135.8 10514.3 10768.6 10774.9 11387.5 11429.7 16380.5 20434.6 20533.0 20562.8 21230.8 7316.6 8185.1 8516.1 8544.2 8598.8 857.5 935.6 938.1 988.1 1021.1 27911.7 29202.3 29286.0 29450.9 29621.6 993.2 1029.8 1032.7 1040.2 1100.2 14296.8 14778.7 14791.5 15186.9 15196.4 622920.0 626674.0 627491.0 628834.0 634265.0 55053.7 55645.0 55773.7 55818.7 55845.9 1232.3 1281.7 1343.5 1389.2 1405.1 24018.8 26483.9 29261.3 30101.8 30126.8 45901.1 46385.8 46391.3 46421.0 46444.8 506723.0 508692.0 510127.0 511050.0 511104.0 24603.3 24948.3 25404.7 25901.6 26070.0 37811.8 38458.0 38697.2 39060.8 39220.8 33138.8 33521.8 33742.5 33785.7 33994.5 32812.7 33632.0 34012.3 34189.7 34535.0 32563.8 33040.8 33090.0 33094.7 33144.7 28489.4 29813.9 30081.7 30231.7 30616.9 20144.5 20873.0 22309.7 22928.7 23099.2 22:18:45 INFO - PROCESS | 1642 | 22:18:45 INFO - PROCESS | 1642 | [#2] jquery.html Cycles:180 Average:33578.46 Median:17940.68 stddev:89287.01 (497.7%) stddev-sans-first:89502.63 22:18:45 INFO - PROCESS | 1642 | Values: 354.1 371.5 373.9 381.5 402.9 14009.4 14113.2 14839.8 18581.8 19286.9 11546.8 11848.3 12133.9 19335.9 20078.0 5101.2 5160.5 5161.8 5326.9 5346.3 5087.5 5256.6 5264.3 5265.2 5269.1 3791.3 3987.5 5543.0 5801.0 5839.2 5628.0 5871.5 5881.0 5881.1 5898.9 5597.9 5677.6 5688.8 5703.6 5705.0 13044.1 13141.3 23977.8 26779.0 26999.0 2450.9 2479.8 2492.8 2600.6 2999.1 15778.7 16777.0 16839.4 16928.4 17539.6 1994.3 2000.5 2020.1 2032.5 2046.3 87261.6 130814.7 133431.0 139300.6 142328.3 19336.4 19848.9 20054.6 20756.8 20785.4 28019.6 29493.9 32745.8 34578.1 34682.7 10202.4 10584.5 10665.0 10683.5 10798.7 8734.5 8746.3 8748.4 8884.2 8945.1 7987.3 9510.8 9600.4 9733.9 9775.1 3135.5 3638.9 3742.2 3766.0 3780.8 842.2 889.1 901.9 913.7 1043.4 19657.7 20023.0 21010.1 21062.1 21085.6 896.8 928.4 934.5 946.1 984.7 9193.9 10310.4 10632.6 10968.7 11081.7 487083.0 516843.4 517029.0 560968.0 565640.0 123815.0 127464.0 128127.0 128685.4 131735.3 975.1 982.8 1031.8 1034.5 1034.5 18157.4 18369.9 18551.9 18557.7 18563.4 36073.6 51444.2 51526.0 51625.7 53830.0 64790.0 67759.0 69396.0 70285.0 72048.6 5719.3 7382.2 7931.6 7937.3 8163.4 11087.0 11907.4 12317.6 12354.0 12403.5 9296.3 9627.0 9761.6 9973.4 10668.3 10351.7 10424.9 10599.6 10986.7 11133.1 10975.9 11031.9 11073.8 11126.0 11143.3 6791.7 7733.9 7822.6 7931.9 8049.9 10589.2 10690.7 10958.8 10979.5 11049.4 22:18:45 INFO - PROCESS | 1642 | 22:18:45 INFO - PROCESS | 1642 | [#3] mootools.html Cycles:180 Average:5368.99 Median:4737.74 stddev:2974.17 (62.8%) stddev-sans-first:2967.79 22:18:45 INFO - PROCESS | 1642 | Values: 1430.4 1478.9 1518.2 1829.5 1878.8 8063.6 8507.8 8515.2 8522.3 8523.8 7430.9 7702.2 7731.6 7987.6 8241.8 2271.3 2327.7 2330.4 2332.5 2336.9 1955.6 2311.7 2323.9 2331.8 2341.5 2311.3 2319.7 2347.5 2351.5 2352.0 2258.9 2273.7 2294.9 2319.5 2325.8 2286.4 2313.9 2315.7 2323.4 2367.1 8319.6 8406.2 8407.7 8410.6 8423.5 5055.6 5218.3 5223.9 5238.8 5240.3 3006.6 3268.3 3362.8 3577.3 3579.1 1023.5 1036.0 1036.4 1040.8 1077.0 10684.0 10897.6 10931.4 10934.3 11028.5 4320.2 4513.5 4538.2 4648.9 4654.2 7693.2 9121.2 9170.5 9183.5 9209.8 4397.3 4411.4 5055.8 5125.7 5229.8 4244.5 4415.0 4416.1 4718.8 4779.3 3221.9 3725.3 3744.2 3864.7 3903.9 1048.5 1049.3 1056.2 1056.4 1076.0 837.7 848.0 857.5 913.5 917.0 4334.7 5385.8 5458.6 5621.8 5793.3 794.8 938.9 943.7 962.5 1004.8 3521.7 3566.1 3630.5 3726.3 3748.9 9818.0 10046.0 10155.1 10190.5 10205.0 10143.8 10148.3 10158.4 10164.8 10165.1 7405.4 7813.7 7946.3 7948.9 7963.8 5424.4 5517.2 5554.4 5623.4 5634.4 7723.8 9009.5 9131.0 9293.3 9427.9 9347.6 9387.9 9453.6 9570.8 9573.7 6588.0 6812.5 6988.0 7001.8 7214.8 7841.8 7941.7 7947.4 8003.0 8021.0 6982.7 7168.4 7173.9 7241.7 7295.1 6974.7 7017.5 7024.5 7120.8 7208.5 6337.9 6343.1 6417.5 6421.7 6447.6 4486.8 4511.2 4552.8 4609.4 4706.5 4575.6 4613.1 4645.9 4663.3 4756.7 22:18:45 INFO - PROCESS | 1642 | 22:18:45 INFO - PROCESS | 1642 | [#4] prototype.html Cycles:180 Average:4562.09 Median:5036.93 stddev:1401.84 (27.8%) stddev-sans-first:1369.67 22:18:45 INFO - PROCESS | 1642 | Values: 350.1 361.5 366.4 372.1 373.2 4395.9 5060.4 5215.9 5336.3 5389.5 4564.9 5191.8 5338.5 5380.9 5398.1 3336.5 3435.3 3927.5 4139.3 4142.5 4209.5 4222.4 4223.1 4248.3 4249.4 4194.8 4198.5 4213.5 4225.9 4240.3 3520.5 3975.5 4108.9 4129.6 4347.6 3041.6 3234.9 3421.9 3648.8 3720.1 4660.1 4956.7 5013.4 5113.8 5237.2 4212.3 4542.8 4619.5 4655.0 4846.0 5145.6 5589.3 5626.7 5633.7 5662.4 3742.4 4056.0 4062.4 4086.3 4088.0 4938.0 5157.6 5445.6 5925.0 5950.5 3970.9 4163.9 4169.2 4183.7 4200.7 3235.8 3868.8 4041.0 4264.3 4288.3 4163.3 4252.4 4411.7 4506.8 4842.8 5437.2 5616.3 5626.3 5717.2 5725.9 1091.2 1274.8 1282.7 1289.4 1293.0 817.3 824.4 840.0 869.4 878.1 4777.0 4796.1 4919.5 5075.6 5108.6 4920.5 4985.0 5111.8 5546.6 5556.5 4433.8 4725.8 4839.9 4987.3 5003.3 2508.8 2559.2 2655.7 2897.4 2963.6 5341.9 5644.8 5746.3 5853.4 5937.6 5393.3 5534.0 5681.5 5729.3 5756.2 5854.4 5925.2 6131.4 6135.6 6153.4 4807.4 5529.5 5551.4 5952.7 5985.6 5322.8 5741.8 5821.2 5874.7 5889.9 5649.2 6007.6 6016.6 6023.9 6059.8 3799.4 3848.7 3849.6 3851.7 3868.8 5086.7 5811.8 5845.3 5916.9 5924.7 5104.7 5393.8 5670.4 5680.8 5749.4 5130.4 5677.2 5686.5 5699.3 5737.4 4877.4 5276.3 5550.5 5603.4 5609.3 4998.3 5012.4 5644.6 5670.9 5698.5 4672.4 5516.4 5557.2 5571.0 5593.7 22:18:45 INFO - PROCESS | 1642 | 22:18:45 INFO - PROCESS | 1642 | [#5] yui.html Cycles:180 Average:20306.69 Median:4272.28 stddev:29837.07 (698.4%) stddev-sans-first:29884.10 22:18:45 INFO - PROCESS | 1642 | Values: 607.4 713.5 731.1 787.1 818.3 11699.9 15000.4 15618.1 15869.8 15914.0 13961.4 14280.1 14356.7 14507.7 14532.4 855.3 878.6 882.1 882.8 884.3 692.7 712.0 713.9 877.3 885.0 895.5 915.6 926.0 936.5 940.2 922.7 923.3 924.5 925.1 927.6 533.3 551.4 682.6 683.6 684.3 13808.0 14341.4 14401.0 14738.6 14744.3 11487.3 14022.3 14099.4 14250.1 14319.7 10597.1 10760.6 10772.1 10970.7 10981.9 3727.2 3792.8 3852.7 3862.2 3864.8 103416.4 103665.0 104588.0 105001.9 105517.5 10467.0 10771.0 10859.4 11073.8 11131.3 20661.9 21988.0 22289.4 22319.6 22335.8 7865.6 7881.5 7883.5 7884.5 7899.1 4134.0 4298.7 4370.7 4475.8 4486.4 3310.5 3539.4 3594.3 3604.2 3613.8 652.5 668.3 672.4 690.1 695.3 543.3 576.7 579.7 645.0 648.0 8888.6 8935.5 9020.7 9204.3 9280.5 654.4 657.3 662.7 669.9 679.0 3956.3 4245.8 4522.8 4559.6 4563.5 100517.7 101399.5 102302.0 104725.5 105311.4 89304.1 89764.6 91589.0 92175.0 93558.0 77147.0 81103.8 81147.0 81842.2 81851.6 7029.5 8666.3 8776.7 8861.5 9038.2 48087.0 49516.8 51698.9 53143.7 53660.5 67632.6 71275.0 71344.0 71380.9 71665.0 11349.1 11514.4 11593.8 11686.8 11966.9 12587.2 12750.4 12803.3 12857.2 13475.9 11682.2 11866.5 11948.3 11953.5 12412.7 11864.2 11895.7 11927.0 12119.8 12392.8 11799.3 11877.8 11879.8 11949.5 12147.1 9909.9 10046.4 10433.4 10459.4 10505.2 9733.4 10007.8 10324.9 10357.2 10382.0 22:18:45 INFO - PROCESS | 1642 | -------- Summary: end -------- 22:18:45 INFO - PROCESS | 1642 | 22:18:46 INFO - TEST-INFO | 1642: exit 0 22:18:46 INFO - TEST-OK | dromaeo_css | took 1120422ms 22:18:46 INFO - TEST-START | kraken 22:18:46 INFO - operating with platform_type : mac_ 22:18:46 INFO - Initialising browser for kraken test... 22:18:46 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/tmpYrFlnT/profile http://localhost:49236/getInfo.html) 22:18:48 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 22:18:48 INFO - PROCESS | 1649 | colorDepth:24 22:18:48 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 22:18:48 INFO - PROCESS | 1649 | __metrics 22:18:48 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" 22:18:48 INFO - PROCESS | 1649 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:18:49 INFO - TEST-INFO | 1649: exit 0 22:18:49 INFO - Browser initialized. 22:18:49 INFO - Running cycle 1/1 for kraken test... 22:18:49 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/tmpYrFlnT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:19:01 INFO - PROCESS | 1650 | RSS: Main: 236584960 22:19:01 INFO - PROCESS | 1650 | 22:19:04 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 22:19:04 INFO - PROCESS | 1650 | RSS: Main: 287465472 22:19:04 INFO - PROCESS | 1650 | 22:19:07 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 22:19:08 INFO - PROCESS | 1650 | RSS: Main: 288579584 22:19:08 INFO - PROCESS | 1650 | 22:19:11 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 22:19:12 INFO - PROCESS | 1650 | RSS: Main: 379674624 22:19:12 INFO - PROCESS | 1650 | 22:19:14 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 22:19:14 INFO - PROCESS | 1650 | RSS: Main: 284295168 22:19:14 INFO - PROCESS | 1650 | 22:19:16 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:19:17 INFO - PROCESS | 1650 | RSS: Main: 286318592 22:19:17 INFO - PROCESS | 1650 | 22:19:20 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 22:19:21 INFO - PROCESS | 1650 | RSS: Main: 327979008 22:19:21 INFO - PROCESS | 1650 | 22:19:23 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 22:19:24 INFO - PROCESS | 1650 | RSS: Main: 330752000 22:19:24 INFO - PROCESS | 1650 | 22:19:27 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 22:19:27 INFO - PROCESS | 1650 | RSS: Main: 325599232 22:19:27 INFO - PROCESS | 1650 | 22:19:29 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:19:30 INFO - PROCESS | 1650 | RSS: Main: 302972928 22:19:30 INFO - PROCESS | 1650 | 22:19:31 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:19:32 INFO - PROCESS | 1650 | RSS: Main: 307093504 22:19:32 INFO - PROCESS | 1650 | 22:19:34 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:19:35 INFO - PROCESS | 1650 | RSS: Main: 308879360 22:19:35 INFO - PROCESS | 1650 | 22:19:38 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:19:39 INFO - PROCESS | 1650 | RSS: Main: 324460544 22:19:39 INFO - PROCESS | 1650 | 22:19:42 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:19:42 INFO - PROCESS | 1650 | RSS: Main: 318795776 22:19:42 INFO - PROCESS | 1650 | 22:19:44 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 22:19:44 INFO - PROCESS | 1650 | RSS: Main: 363106304 22:19:44 INFO - PROCESS | 1650 | 22:19:44 INFO - PROCESS | 1650 | __start_tp_report 22:19:44 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 22:19:44 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 22:19:44 INFO - PROCESS | 1650 | |i|pagename|runs| 22:19:44 INFO - PROCESS | 1650 | |0;ai-astar;113;111;111;112;111;111;110;112;111;111 22:19:44 INFO - PROCESS | 1650 | |1;audio-beat-detection;149;111;109;149;108;111;113;140;166;108 22:19:44 INFO - PROCESS | 1650 | |2;audio-dft;182;191;257;206;183;185;178;182;183;183 22:19:44 INFO - PROCESS | 1650 | |3;audio-fft;79;59;58;89;65;59;58;58;76;58 22:19:44 INFO - PROCESS | 1650 | |4;audio-oscillator;86;70;87;69;68;69;83;68;69;84 22:19:44 INFO - PROCESS | 1650 | |5;imaging-gaussian-blur;108;110;108;109;108;109;106;110;107;108 22:19:44 INFO - PROCESS | 1650 | |6;imaging-darkroom;94;93;94;93;93;94;94;93;93;93 22:19:44 INFO - PROCESS | 1650 | |7;imaging-desaturate;84;85;86;87;87;87;85;86;88;87 22:19:44 INFO - PROCESS | 1650 | |8;json-parse-financial;54;53;53;54;56;55;56;55;54;55 22:19:44 INFO - PROCESS | 1650 | |9;json-stringify-tinderbox;64;79;73;73;73;68;70;70;70;70 22:19:44 INFO - PROCESS | 1650 | |10;stanford-crypto-aes;87;87;86;87;87;86;89;86;84;77 22:19:44 INFO - PROCESS | 1650 | |11;stanford-crypto-ccm;141;141;139;139;141;140;137;139;187;151 22:19:44 INFO - PROCESS | 1650 | |12;stanford-crypto-pbkdf2;173;174;230;211;172;171;169;169;170;171 22:19:44 INFO - PROCESS | 1650 | |13;stanford-crypto-sha256-iterative;67;66;67;66;67;67;67;64;66;66 22:19:44 INFO - PROCESS | 1650 | __end_tp_report 22:19:44 INFO - PROCESS | 1650 | __start_cc_report 22:19:44 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,1997 22:19:44 INFO - PROCESS | 1650 | __end_cc_report 22:19:44 INFO - PROCESS | 1650 | __startTimestamp1482301184662__endTimestamp 22:19:44 INFO - PROCESS | 1650 | 22:19:44 INFO - PROCESS | 1650 | ------- Summary: start ------- 22:19:44 INFO - PROCESS | 1650 | Number of tests: 14 22:19:44 INFO - PROCESS | 1650 | 22:19:44 INFO - PROCESS | 1650 | [#0] ai-astar Cycles:10 Average:111.30 Median:111.00 stddev:0.82 (0.7%) stddev-sans-first:0.60 22:19:44 INFO - PROCESS | 1650 | Values: 113.0 111.0 111.0 112.0 111.0 111.0 110.0 112.0 111.0 111.0 22:19:44 INFO - PROCESS | 1650 | 22:19:44 INFO - PROCESS | 1650 | [#1] audio-beat-detection Cycles:10 Average:126.40 Median:126.50 stddev:22.13 (17.5%) stddev-sans-first:21.91 22:19:44 INFO - PROCESS | 1650 | Values: 149.0 111.0 109.0 149.0 108.0 111.0 113.0 140.0 166.0 108.0 22:19:44 INFO - PROCESS | 1650 | 22:19:44 INFO - PROCESS | 1650 | [#2] audio-dft Cycles:10 Average:193.00 Median:184.00 stddev:23.80 (12.9%) stddev-sans-first:24.91 22:19:44 INFO - PROCESS | 1650 | Values: 182.0 191.0 257.0 206.0 183.0 185.0 178.0 182.0 183.0 183.0 22:19:44 INFO - PROCESS | 1650 | 22:19:44 INFO - PROCESS | 1650 | [#3] audio-fft Cycles:10 Average:65.90 Median:62.00 stddev:11.32 (18.3%) stddev-sans-first:10.97 22:19:44 INFO - PROCESS | 1650 | Values: 79.0 59.0 58.0 89.0 65.0 59.0 58.0 58.0 76.0 58.0 22:19:44 INFO - PROCESS | 1650 | 22:19:44 INFO - PROCESS | 1650 | [#4] audio-oscillator Cycles:10 Average:75.30 Median:76.50 stddev:8.43 (11.0%) stddev-sans-first:8.01 22:19:44 INFO - PROCESS | 1650 | Values: 86.0 70.0 87.0 69.0 68.0 69.0 83.0 68.0 69.0 84.0 22:19:44 INFO - PROCESS | 1650 | 22:19:44 INFO - PROCESS | 1650 | [#5] imaging-gaussian-blur Cycles:10 Average:108.30 Median:108.50 stddev:1.25 (1.2%) stddev-sans-first:1.32 22:19:44 INFO - PROCESS | 1650 | Values: 108.0 110.0 108.0 109.0 108.0 109.0 106.0 110.0 107.0 108.0 22:19:44 INFO - PROCESS | 1650 | 22:19:44 INFO - PROCESS | 1650 | [#6] imaging-darkroom Cycles:10 Average:93.40 Median:93.50 stddev:0.52 (0.6%) stddev-sans-first:0.50 22:19:44 INFO - PROCESS | 1650 | Values: 94.0 93.0 94.0 93.0 93.0 94.0 94.0 93.0 93.0 93.0 22:19:44 INFO - PROCESS | 1650 | 22:19:44 INFO - PROCESS | 1650 | [#7] imaging-desaturate Cycles:10 Average:86.20 Median:87.00 stddev:1.23 (1.4%) stddev-sans-first:1.01 22:19:44 INFO - PROCESS | 1650 | Values: 84.0 85.0 86.0 87.0 87.0 87.0 85.0 86.0 88.0 87.0 22:19:44 INFO - PROCESS | 1650 | 22:19:44 INFO - PROCESS | 1650 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:55.00 stddev:1.08 (2.0%) stddev-sans-first:1.13 22:19:44 INFO - PROCESS | 1650 | Values: 54.0 53.0 53.0 54.0 56.0 55.0 56.0 55.0 54.0 55.0 22:19:44 INFO - PROCESS | 1650 | 22:19:44 INFO - PROCESS | 1650 | [#9] json-stringify-tinderbox Cycles:10 Average:71.00 Median:71.50 stddev:3.92 (5.5%) stddev-sans-first:3.23 22:19:44 INFO - PROCESS | 1650 | Values: 64.0 79.0 73.0 73.0 73.0 68.0 70.0 70.0 70.0 70.0 22:19:44 INFO - PROCESS | 1650 | 22:19:44 INFO - PROCESS | 1650 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:87.00 stddev:3.27 (3.8%) stddev-sans-first:3.43 22:19:44 INFO - PROCESS | 1650 | Values: 87.0 87.0 86.0 87.0 87.0 86.0 89.0 86.0 84.0 77.0 22:19:44 INFO - PROCESS | 1650 | 22:19:44 INFO - PROCESS | 1650 | [#11] stanford-crypto-ccm Cycles:10 Average:145.50 Median:141.00 stddev:15.06 (10.7%) stddev-sans-first:15.89 22:19:44 INFO - PROCESS | 1650 | Values: 141.0 141.0 139.0 139.0 141.0 140.0 137.0 139.0 187.0 151.0 22:19:44 INFO - PROCESS | 1650 | 22:19:44 INFO - PROCESS | 1650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.00 Median:172.50 stddev:21.35 (12.4%) stddev-sans-first:22.45 22:19:44 INFO - PROCESS | 1650 | Values: 173.0 174.0 230.0 211.0 172.0 171.0 169.0 169.0 170.0 171.0 22:19:44 INFO - PROCESS | 1650 | 22:19:44 INFO - PROCESS | 1650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:67.00 stddev:0.95 (1.4%) stddev-sans-first:0.97 22:19:44 INFO - PROCESS | 1650 | Values: 67.0 66.0 67.0 66.0 67.0 67.0 67.0 64.0 66.0 66.0 22:19:44 INFO - PROCESS | 1650 | -------- Summary: end -------- 22:19:44 INFO - PROCESS | 1650 | 22:19:45 INFO - TEST-INFO | 1650: exit 0 22:19:45 INFO - TEST-OK | kraken | took 59307ms 22:19:45 INFO - SUITE-END | took 1179s 22:19:45 INFO - Completed test suite (00:19:39) 22:19:45 INFO - javascript benchmark 22:19:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3333.416652085885, 3350.916227094323, 3358.076528954537, 3368.208471009314, 3409.2840503494267, 5533.750981205845, 5623.746931388087, 5632.380438151805, 5719.656820590768, 5732.2261494698205, 5612.438756124386, 5629.6340737852115, 5686.402927692585, 5708.828735137942, 5723.055695810197, 5082.390113186423, 5123.7438128093445, 5127.051495473331, 5188.143956247215, 5206.7656955436905, 5232.764525596338, 5349.759260833272, 5354.0, 5364.302640656709, 5408.296921400212, 5127.846164615067, 5299.231611416361, 5334.03987282289, 5353.0, 5397.379301380352, 4532.116237333721, 4950.950490495121, 5168.741562921877, 5207.765650545697, 5234.738263086869, 5188.92216616751, 5193.143131383317, 5219.5041471060185, 5220.817271395483, 5243.895122097575, 5687.744051517691, 5700.828975130753, 5725.08398656213, 5733.713314334266, 5760.942390576124, 5943.286805583358, 5956.851078723023, 5970.223870896755, 6157.969210153965, 6243.219597550306, 6225.346338634424, 6293.748250069992, 6302.46429053531, 6303.086052522359, 6332.1135041094285, 5780.3063632363965, 5804.2744656917885, 5812.011957967071, 5815.360310365856, 5864.999999999957, 5890.028145355968, 6215.595986260879, 6247.781327653511, 6295.24457065146, 6298.464630506458, 4793.352897358882, 6074.54440916933, 6099.9390006099375, 6115.052166914135, 6212.751489940351, 6280.591761535486, 6285.528585356116, 6310.652914089677, 6310.810675679737, 6319.46284565817, 6118.1128736332985, 6244.000959846403, 6249.0, 6265.686715664198, 6267.122602835607, 6101.065651476929, 6110.877782444326, 6127.128444391265, 6254.843628909222, 6261.812145635638, 4922.556969872729, 4929.630277729113, 4933.531314525115, 4936.308916751657, 4946.579540739078, 4363.978180109079, 4450.888727781831, 4475.440569928759, 4487.708298960557, 4506.932396014063, 5655.462731040545, 5702.344230413555, 5708.4862362387585, 5711.057675483582, 5738.68437235956, 6244.375562443719, 6295.37046295376, 6297.748090076346, 6306.0, 6308.621482711052, 5779.797707080316, 5785.103308987113, 5786.189933409326, 5793.15999180125, 5846.795362162304, 5254.133068043807, 5280.656757310762, 5406.351237851404, 5420.403755586883, 5420.512153906167, 5250.26496290512, 6249.968750156311, 6300.306966233619, 6315.115883776183, 6332.176817013758, 6271.184745982993, 6275.435210831047, 6294.3076261612105, 6302.0, 6318.368163183645, 5177.663451875616, 6268.4671802897265, 6318.652474113784, 6334.0, 6340.397662222082, 6004.549658775697, 6060.2424696912885, 6103.786367477117, 6131.0, 6216.347283535345, 6250.1874756281395, 6279.937200627935, 6288.339724328879, 6289.182406287154, 6300.527460440394, 6022.909656355246, 6111.877762444815, 6135.877282454415, 6159.630422174684, 6160.291566469913, 5007.674501157413, 5519.613627046068, 5909.261342332208, 5973.910391344047, 6084.11780291864, 5904.734286957011, 6011.519078473799, 6012.669303188191, 6059.787907423219, 6071.089336599369, 6132.877342453036, 6153.538484613582, 6171.259448866164, 6183.690815459299, 6184.6598437086395, 5713.371529131875, 5792.160136780228, 5979.730912108878, 5986.640801551921, 6054.3642917493025], "value": 5676.129098908994, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [422.65342419216233, 469.97415142167165, 492.2345752355088, 495.41046155075435, 502.10625087344516, 24241.757582424172, 32803.88363105507, 37249.62750372499, 37789.05527361817, 39349.21301573974, 39600.0, 39879.401808972885, 40375.15498140227, 40453.393199102036, 40467.392989105116, 8336.541490218036, 9142.725718228463, 9346.252299815998, 9348.859767103499, 9354.438733676001, 8410.78973025673, 10878.129749620051, 11179.329240245612, 11186.44067796607, 11366.71583210418, 11127.108391573453, 11186.161037922147, 11202.943985280062, 11204.439778011109, 11265.549378024869, 11086.722831929186, 11151.944240278828, 11164.995150436418, 11179.552817887276, 11180.993710566006, 10974.561017559368, 11070.28043177191, 11071.003609675088, 11072.667819965414, 11084.944575277153, 37908.0, 38192.427113593316, 38194.23611527782, 38216.61783382158, 38228.42657360142, 3215.099772063826, 3282.6881446262805, 3459.187091033605, 3480.512728218026, 3656.981715091434, 26306.73693263081, 27815.58276625852, 27816.86091569529, 27887.581686274723, 27888.0, 3058.204866734665, 3210.7431405487737, 3253.6746325367276, 3273.0998975281987, 3274.4433446314183, 456378.0, 456478.0, 457544.0, 457994.9999999967, 459181.0, 52968.73515632397, 53132.0, 53273.46726532685, 53425.46574534205, 53526.73236633792, 54124.963754711636, 54301.1854822178, 54336.72831635817, 54430.727846361304, 54461.72769136208, 12035.0, 14780.260986950609, 15043.022203556733, 15054.0, 15135.772963405558, 10514.264001519974, 10768.569257229623, 10774.892251077546, 11387.487563059682, 11429.657110286706, 16380.49666007193, 20434.591308173753, 20533.0, 20562.794372056087, 21230.78769212319, 7316.561006339637, 8185.140560241208, 8516.06323304436, 8544.2310192083, 8598.78503037429, 857.4769390671685, 935.5649622925372, 938.136914039072, 988.1452543549777, 1021.0810270756378, 27911.720882790913, 29202.269943251587, 29285.974990875642, 29450.887867875324, 29621.555676664866, 993.1558175550724, 1029.7528593137743, 1032.731489812639, 1040.1834559870465, 1100.2188446203286, 14296.785548216785, 14778.704425911421, 14791.482298119514, 15186.924065379602, 15196.392144314324, 622920.0, 626674.0, 627491.0, 628834.0, 634265.0, 55053.72473137689, 55645.0, 55773.721131394086, 55818.72090639521, 55845.88308233813, 1232.279116716713, 1281.653953432568, 1343.536479914428, 1389.1873254146235, 1405.051590176647, 24018.75981240165, 26483.94064237486, 29261.26846828761, 30101.849490752407, 30126.849365753907, 45901.08197835958, 46385.84035399142, 46391.3041304374, 46421.0, 46444.7677761609, 506723.0, 508692.0, 510127.0, 511050.0, 511104.0, 24603.325368179987, 24948.251552453454, 25404.745952540237, 25901.611475828253, 26070.0, 37811.81094094512, 38458.0, 38697.226055479296, 39060.80469597634, 39220.82337529879, 33138.83430582831, 33521.83239083789, 33742.49386259257, 33785.66214337825, 33994.490082648284, 32812.67187328096, 33632.0, 34012.31975360429, 34189.658103418646, 34535.0, 32563.837180813945, 33040.83479582587, 33090.0, 33094.66905330916, 33144.668553315125, 28489.43021139607, 29813.850930745208, 30081.69918300789, 30231.69768302289, 30616.92840750563, 20144.489163312515, 20873.0, 22309.665355019362, 22928.656070159293, 23099.19152829643], "value": 19002.764467261804, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.06879905847615, 371.4521081404926, 373.85793398508565, 381.49451976131616, 402.88115006073207, 14009.369578368973, 14113.223772692498, 14839.777403338945, 18581.81418185818, 19286.90356548219, 11546.769064618702, 11848.34834084125, 12133.907948284652, 19335.90332048338, 20078.0, 5101.15830887903, 5160.483951604847, 5161.799684195804, 5326.934613077381, 5346.27825243591, 5087.516685914832, 5256.579473642099, 5264.315638966948, 5265.157574788034, 5269.051570717269, 3791.298609757204, 3987.5214974203136, 5543.0, 5801.0, 5839.240898683165, 5628.0, 5871.471567558919, 5880.97059514704, 5881.117832325142, 5898.879212949526, 5597.860053498654, 5677.630953987978, 5688.776912963691, 5703.600747947646, 5705.0, 13044.08691391603, 13141.342932853318, 23977.760222397726, 26779.0, 26999.0, 2450.914218002379, 2479.801615870726, 2492.763187497185, 2600.596907479344, 2999.0552975812766, 15778.684426311524, 16777.0, 16839.410620628343, 16928.40750573724, 17539.649207015787, 1994.2521554417094, 2000.5298754792611, 2020.111151093514, 2032.5223572460459, 2046.3144846476448, 87261.56369218176, 130814.6918530812, 133431.0, 139300.60699392977, 142328.28835855858, 19336.4199074028, 19848.90075549613, 20054.59890802176, 20756.792432075486, 20785.376438706862, 28019.579706304423, 29493.852530737637, 32745.836270818494, 34578.135546611535, 34682.65317346845, 10202.38785672862, 10584.523696433678, 10665.0, 10683.465826708634, 10798.73003174927, 8734.475931444134, 8746.300295976307, 8748.431351962103, 8884.200421962054, 8945.06076861933, 7987.32107770846, 9510.809783804423, 9600.423974561549, 9733.902660973441, 9775.120239178508, 3135.5139953307275, 3638.87194969555, 3742.1954279829965, 3765.962340376616, 3780.8298626561323, 842.2419822159983, 889.0798024045082, 901.8917729872458, 913.6893456224783, 1043.3739756146251, 19657.705134422995, 20023.0, 21010.054547545093, 21062.052207650388, 21085.566994949022, 896.8296023755465, 928.3872644054892, 934.4626839567276, 946.0633972367444, 984.7193549838405, 9193.862092068624, 10310.432926188982, 10632.627858025087, 10968.725781855517, 11081.667549973514, 487083.0, 516843.4157829187, 517029.0, 560968.0, 565640.0, 123815.0, 127464.0, 128127.0, 128685.35657321653, 131735.34132329276, 975.059067999384, 982.823091843475, 1031.83490641497, 1034.5189486888482, 1034.5396298647029, 18157.36449224271, 18369.897806131674, 18551.90724046371, 18557.72163417523, 18563.35028274004, 36073.63926360703, 51444.22833657573, 51526.0, 51625.741871290404, 53830.0, 64790.0, 67759.0, 69396.0, 70285.0, 72048.63975680088, 5719.28508936383, 7382.187959324363, 7931.643076061707, 7937.285644292041, 8163.428560000743, 11087.0, 11907.404629768303, 12317.568885089337, 12354.0, 12403.503859845505, 9296.349255552317, 9626.95186524063, 9761.609535618496, 9973.351732137387, 10668.253222274367, 10351.741206469898, 10424.94787526088, 10599.576016959236, 10986.670399888017, 11133.109351251718, 10975.945120274348, 11031.944840275748, 11073.778524429628, 11126.0, 11143.275687080313, 6791.66041697923, 7733.92266077332, 7822.569758663328, 7931.920680793118, 8049.87925181111, 10589.205809564159, 10690.732731681459, 10958.780824383628, 10979.51776510193, 11049.39228342449], "value": 10078.60532695689, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1430.356339647159, 1478.9112653240804, 1518.2332921874456, 1829.4968883557028, 1878.8496920246382, 8063.59682015899, 8507.829843403137, 8515.191056849604, 8522.275606573434, 8523.78690532737, 7430.925690743091, 7702.152763196044, 7731.574763388011, 7987.600619969007, 8241.83516329673, 2271.2731925783755, 2327.6857624220766, 2330.3707998840305, 2332.47519308156, 2336.8597884127007, 1955.5599990002206, 2311.6763653088583, 2323.942606114214, 2331.7901388875, 2341.4731685370825, 2311.3181611424584, 2319.675245465636, 2347.4600841806396, 2351.529694061186, 2352.0121548949396, 2258.943526411853, 2273.6816845641624, 2294.9311520654405, 2319.512902290521, 2325.837191396603, 2286.3826766773045, 2313.9305820825402, 2315.7452680205165, 2323.4307594639254, 2367.0650093213085, 8319.584020798935, 8406.24343809054, 8407.70573029947, 8410.579471026424, 8423.452475589067, 5055.5702765265, 5218.321618189649, 5223.947760522422, 5238.81664141757, 5240.34495688039, 3006.5790789289517, 3268.346330733863, 3362.7646064775477, 3577.302426026926, 3579.087332730137, 1023.4575674892319, 1035.9533820978074, 1036.3833519056225, 1040.8126537223297, 1076.95692172313, 10684.0, 10897.618583349546, 10931.398773067478, 10934.343939363584, 11028.50371733274, 4320.243957307459, 4513.480949690762, 4538.205813982539, 4648.86053418398, 4654.16225079489, 7693.230676932262, 9121.179093881583, 9170.541472926327, 9183.540822958825, 9209.76975575616, 4397.340398940185, 4411.404460397869, 5055.823046193439, 5125.743712814345, 5229.843104706789, 4244.490661120623, 4414.955850441519, 4416.094700586372, 4718.764061796896, 4779.259214821639, 3221.8872339468007, 3725.3480640887738, 3744.194998075427, 3864.7487913285545, 3903.902402439962, 1048.4705223861902, 1049.2917280835406, 1056.1550759392455, 1056.3556230699267, 1075.983860242097, 837.6942416018231, 848.0, 857.5197889182078, 913.5386629752065, 917.0233701108299, 4334.653227741836, 5385.78456861729, 5458.635341164709, 5621.831345059655, 5793.304803423616, 794.8370584030259, 938.8591711243369, 943.6980166346704, 962.5235508423375, 1004.7538353103537, 3521.7006554442646, 3566.1262990566956, 3630.49173115764, 3726.32926073304, 3748.887533374003, 9817.950910245403, 10046.04562566555, 10155.136813370798, 10190.490475476197, 10205.03052210039, 10143.847842282372, 10148.289619726696, 10158.441285729356, 10164.847527287096, 10165.085142337077, 7405.407567394595, 7813.68745250195, 7946.324562412144, 7948.887155798193, 7963.8407231855035, 5424.403315635356, 5517.200005999028, 5554.416786237387, 5623.437656234508, 5634.380218176079, 7723.845523089394, 9009.54952252398, 9131.041240669634, 9293.25653947669, 9427.905720942703, 9347.579358928728, 9387.85918211241, 9453.621855125717, 9570.808583828424, 9573.712788616353, 6588.0, 6812.523123381514, 6987.965060174666, 7001.789946301619, 7214.819629509304, 7841.764747057598, 7941.722039728582, 7947.403944704055, 8002.9599852000365, 8021.037475502977, 6982.68577913985, 7168.4265258780215, 7173.928260717535, 7241.746538871114, 7295.051643286339, 6974.68613912365, 7017.508774385744, 7024.5082844200415, 7120.750773722895, 7208.495405321577, 6337.936620633919, 6343.080253363144, 6417.518686098655, 6421.743130274736, 6447.6131432114225, 4486.820527179007, 4511.210538155744, 4552.840650577214, 4609.354690343422, 4706.458757242961, 4575.633949284116, 4613.1004454131125, 4645.883852903705, 4663.300504924153, 4756.7145971241835], "value": 4340.570675793643, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.147391102665, 361.53001098571866, 366.4411772047629, 372.07539264926635, 373.210659455252, 4395.857077159942, 5060.41805192403, 5215.930734199489, 5336.279602253704, 5389.4610538946135, 4564.931526027104, 5191.792328306863, 5338.546223570991, 5380.892382152364, 5398.082326004579, 3336.5328853960464, 3435.2823588205897, 3927.5286965564173, 4139.275626765319, 4142.502899652046, 4209.452771139763, 4222.387753775701, 4223.070924396628, 4248.299030659938, 4249.426327445786, 4194.769287689176, 4198.496180458349, 4213.51544572375, 4225.915481690365, 4240.342746874239, 3520.507129001929, 3975.542812576533, 4108.91782164358, 4129.648979836717, 4347.60881515167, 3041.5893854329825, 3234.9029529113927, 3421.853679017532, 3648.7958973538935, 3720.088578298334, 4660.067986402733, 4956.653034287601, 5013.448520662724, 5113.846584602468, 5237.214417837316, 4212.283911734982, 4542.772861356919, 4619.514950930171, 4654.976725116387, 4846.0, 5145.614078944057, 5589.301337332833, 5626.690532020737, 5633.746481408305, 5662.37713851476, 3742.3825068863603, 4056.0468289951837, 4062.3500239961463, 4086.2849001424634, 4088.0393107619684, 4938.0, 5157.607445989562, 5445.591580631429, 5925.0, 5950.494207992283, 3970.900727481778, 4163.855614358607, 4169.207850508394, 4183.728057676241, 4200.663946884242, 3235.7934684909524, 3868.8065596720053, 4040.959590404117, 4264.296391095497, 4288.335308027261, 4163.3130533462245, 4252.362145678111, 4411.735295882258, 4506.819727210875, 4842.830500932521, 5437.211604317431, 5616.2698849150165, 5626.324841019022, 5717.2281741965135, 5725.914111288334, 1091.2034215022918, 1274.789659706138, 1282.6596206963745, 1289.4197611075053, 1293.0237670558856, 817.2603793566832, 824.3775949158347, 839.992009588484, 869.443556124081, 878.1262643669589, 4776.9841666250295, 4796.136695394793, 4919.483454237254, 5075.56857667095, 5108.6168537359845, 4920.458749537548, 4984.962180633625, 5111.827473323822, 5546.611737178439, 5556.527170518426, 4433.849582952265, 4725.834595789131, 4839.942260337955, 4987.326710894055, 5003.324551185616, 2508.8243822932586, 2559.1938539360044, 2655.668041494813, 2897.391547774949, 2963.555466679972, 5341.916652505526, 5644.774209031592, 5746.339170995306, 5853.443922827325, 5937.643741375531, 5393.325834270716, 5533.972330138324, 5681.454836131161, 5729.255196824386, 5756.229669566441, 5854.414558544197, 5925.185536870038, 6131.448169664752, 6135.631862088289, 6153.4154255345675, 4807.351007613927, 5529.498149341431, 5551.389347171888, 5952.672603006876, 5985.5810093294795, 5322.840314790563, 5741.827745167651, 5821.214136091573, 5874.706264686834, 5889.911651325147, 5649.164021693048, 6007.605702777916, 6016.616178278933, 6023.939760602338, 6059.757609695739, 3799.404250214861, 3848.6536211741077, 3849.615038496128, 3851.7111216659423, 3868.7678739274606, 5086.745662716923, 5811.79658711943, 5845.327787304344, 5916.8640620471215, 5924.74139223434, 5104.719240441811, 5393.786398060405, 5670.432956704297, 5680.835428737017, 5749.425057494384, 5130.358705161855, 5677.176809362537, 5686.545076393796, 5699.316082070012, 5737.368889422077, 4877.3903262092235, 5276.287701160294, 5550.47270509301, 5603.38362780102, 5609.317204838614, 4998.2502624606595, 5012.398512178416, 5644.576656750678, 5670.92252472029, 5698.515626171822, 4672.439307283148, 5516.420775818481, 5557.166425036277, 5571.0, 5593.748281327432], "value": 4121.967741534404, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [607.4472230270453, 713.5148099292479, 731.0715391452852, 787.1420152034285, 818.2890591169046, 11699.941500292498, 15000.39998400064, 15618.062916225035, 15869.841301586981, 15914.0, 13961.371738271777, 14280.143191408522, 14356.712865742678, 14507.709845803078, 14532.418703251857, 855.3285670748463, 878.6002368922125, 882.1443200095897, 882.7969566999594, 884.2969838977996, 692.6779047742799, 712.010305675112, 713.878640631094, 877.3113106211625, 884.9999500564353, 895.476146454325, 915.5925613102172, 925.9583318750639, 936.5410948635188, 940.2008292951006, 922.7324076017946, 923.3398120343953, 924.4869097650835, 925.065683659502, 927.601131513449, 533.3439868961161, 551.3714365623193, 682.6450245872119, 683.565935630873, 684.3259389501337, 13807.962248305457, 14341.426342946374, 14400.991930564865, 14738.55784326472, 14744.262786860721, 11487.25332853362, 14022.298885055809, 14099.436022559084, 14250.14499130045, 14319.713605727931, 10597.120369356931, 10760.623378181805, 10772.138228941665, 10970.670879873536, 10981.890181098166, 3727.1613886875234, 3792.829322680486, 3852.6917846572487, 3862.1696335287766, 3864.787436690981, 103416.44875326876, 103664.96335036629, 104588.0, 105001.94998050075, 105517.47241263745, 10467.0, 10771.030607245386, 10859.402732849769, 11073.778524429628, 11131.332120072822, 20661.89669051675, 21988.0, 22289.44276393103, 22319.55360892773, 22335.776642233694, 7865.646045927947, 7881.487703299267, 7883.526988380716, 7884.487508311941, 7899.052113746272, 4133.958660413417, 4298.742075475419, 4370.672199585044, 4475.7985890635, 4486.439195100613, 3310.526815567098, 3539.3629146753315, 3594.281143771256, 3604.1710406606626, 3613.7831730096277, 652.5432197461796, 668.2548957911894, 672.4418732452151, 690.0752990992095, 695.2734392559787, 543.2530270877544, 576.6828244465527, 579.6753817861927, 644.9516286278548, 647.9643619600968, 8888.64445422176, 8935.508547029976, 9020.684276050439, 9204.263658907272, 9280.535973201313, 654.4142992022208, 657.2769953051701, 662.6951602263013, 669.902864084705, 678.9932100679029, 3956.3076461619103, 4245.80893859777, 4522.796474158671, 4559.635229181657, 4563.452385713669, 100517.65317237469, 101399.47900781494, 102302.0, 104725.47637261765, 105311.36721582022, 89304.10695893088, 89764.5511772437, 91589.0, 92175.0, 93558.0, 77147.0, 81103.78344324957, 81147.0, 81842.18157818465, 81851.59074204591, 7029.507934444539, 8666.340889372175, 8776.692815751418, 8861.468311901306, 9038.186563209343, 48087.03825923392, 49516.75241623769, 51698.93204271787, 53143.73428132835, 53660.46339536554, 67632.6473470518, 71275.0, 71344.0, 71380.92928606179, 71665.0, 11349.092072634005, 11514.424278786195, 11593.768124637629, 11686.766264674488, 11966.880331196577, 12587.181833180814, 12750.362481876055, 12803.29581873006, 12857.164284321489, 13475.865241347854, 11682.24065435744, 11866.466009029442, 11948.283103013848, 11953.488139875124, 12412.689682758004, 11864.169508134348, 11895.702607434883, 11927.0, 12119.818202727143, 12392.75214495723, 11799.292042477478, 11877.821832672344, 11879.82180267314, 11949.522019119138, 12147.149699520949, 9909.900900991186, 10046.387939136024, 10433.426161561187, 10459.372437653765, 10505.212109092, 9733.367331123454, 10007.849882251627, 10324.896751032695, 10357.22320825926, 10382.0], "value": 7248.003505275028, "unit": "score"}], "name": "dromaeo_css", "value": 7214.3573191110245, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 111.0, 111.0, 112.0, 111.0, 111.0, 110.0, 112.0, 111.0, 111.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 111.0, 109.0, 149.0, 108.0, 111.0, 113.0, 140.0, 166.0, 108.0], "value": 126.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 191.0, 257.0, 206.0, 183.0, 185.0, 178.0, 182.0, 183.0, 183.0], "value": 193.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 59.0, 58.0, 89.0, 65.0, 59.0, 58.0, 58.0, 76.0, 58.0], "value": 65.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 70.0, 87.0, 69.0, 68.0, 69.0, 83.0, 68.0, 69.0, 84.0], "value": 75.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 110.0, 108.0, 109.0, 108.0, 109.0, 106.0, 110.0, 107.0, 108.0], "value": 108.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 93.0, 93.0, 94.0, 94.0, 93.0, 93.0, 93.0], "value": 93.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 86.0, 87.0, 87.0, 87.0, 85.0, 86.0, 88.0, 87.0], "value": 86.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 54.0, 56.0, 55.0, 56.0, 55.0, 54.0, 55.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 79.0, 73.0, 73.0, 73.0, 68.0, 70.0, 70.0, 70.0, 70.0], "value": 71.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 86.0, 87.0, 87.0, 86.0, 89.0, 86.0, 84.0, 77.0], "value": 85.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 141.0, 139.0, 139.0, 141.0, 140.0, 137.0, 139.0, 187.0, 151.0], "value": 145.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 174.0, 230.0, 211.0, 172.0, 171.0, 169.0, 169.0, 170.0, 171.0], "value": 181.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 66.0, 67.0, 67.0, 67.0, 64.0, 66.0, 66.0], "value": 66.3, "unit": "score"}], "name": "kraken", "value": 1463.6999999999998, "alertThreshold": 2.0}]} 22:19:45 INFO - Return code: 0 22:19:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:19:45 INFO - # TBPL SUCCESS # 22:19:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:19:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:19:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:19:45 INFO - 2016-12-20 22:19:45.998 screenresolution[1654:9635] starting screenresolution argv=screenresolution get 22:19:46 INFO - 2016-12-20 22:19:46.000 screenresolution[1654:9635] Display 0: 1600x1200x32@60 22:19:46 INFO - 2016-12-20 22:19:46.007 screenresolution[1655:9638] starting screenresolution argv=screenresolution list 22:19:46 INFO - Available Modes on Display 0 22:19:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:19:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:19:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:19:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:19:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:19:46 INFO - Intel Iris: 22:19:46 INFO - Chipset Model: Intel Iris 22:19:46 INFO - Type: GPU 22:19:46 INFO - Bus: Built-In 22:19:46 INFO - VRAM (Dynamic, Max): 1536 MB 22:19:46 INFO - Vendor: Intel (0x8086) 22:19:46 INFO - Device ID: 0x0a2e 22:19:46 INFO - Revision ID: 0x0009 22:19:46 INFO - Displays: 22:19:46 INFO - Display: 22:19:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:19:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:19:46 INFO - Display Serial Number: 1600x1200 60 22:19:46 INFO - Main Display: Yes 22:19:46 INFO - Mirror: Off 22:19:46 INFO - Online: Yes 22:19:46 INFO - Rotation: Supported 22:19:46 INFO - Return code: 0 22:19:46 INFO - Running post-action listener: _resource_record_post_action 22:19:46 INFO - [mozharness: 2016-12-21 06:19:46.241680Z] Finished run-tests step (success) 22:19:46 INFO - Running post-run listener: _resource_record_post_run 22:19:46 INFO - Total resource usage - Wall time: 1203s; CPU: 54.0%; Read bytes: 37553152; Write bytes: 549316096; Read time: 239; Write time: 1677 22:19:46 INFO - TinderboxPrint: CPU usage
53.6% 22:19:46 INFO - TinderboxPrint: I/O read bytes / time
37,553,152 / 239 22:19:46 INFO - TinderboxPrint: I/O write bytes / time
549,316,096 / 1,677 22:19:46 INFO - TinderboxPrint: CPU idle
2,231.9 (46.4%) 22:19:46 INFO - TinderboxPrint: CPU system
957.0 (19.9%) 22:19:46 INFO - TinderboxPrint: CPU user
1,624.9 (33.8%) 22:19:46 INFO - TinderboxPrint: Swap in / out
286,482,432 / 0 22:19:46 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 238047744; Write bytes: 225148928; Read time: 17487; Write time: 466 22:19:46 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 31398912; Write bytes: 299116032; Read time: 184; Write time: 1149 22:19:46 INFO - Running post-run listener: _upload_blobber_files 22:19:46 INFO - Blob upload gear active. 22:19:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:19:46 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:19:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:19:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:19:47 INFO - (blobuploader) - INFO - Open directory for files ... 22:19:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:19:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:19:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:19:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:19:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:19:48 INFO - (blobuploader) - INFO - Done attempting. 22:19:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:19:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:19:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:19:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:19:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:19:49 INFO - (blobuploader) - INFO - Done attempting. 22:19:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 22:19:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:19:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:19:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 22:19:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:19:50 INFO - (blobuploader) - INFO - Done attempting. 22:19:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:19:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:19:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:19:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:19:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:19:53 INFO - (blobuploader) - INFO - Done attempting. 22:19:53 INFO - (blobuploader) - INFO - Iteration through files over. 22:19:53 INFO - Return code: 0 22:19:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:19:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:19:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/18f627f6def02bb8733f6afb947bf57c0812c96c0d428daf0ee0899d27d7d3c3b331e2f19ac26a922c7eef09ff90d8898ed3c1de8697b76066eba341af55b09d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/086e0ba477d728fb2c583f555cada795eb5f0be8136fcffbae305f8d6e0d5adbff29548aa81e45a7f53770f9ea00468a714a203ff502630fb4e08d393b7cc31b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c3b21ef8bc1020170a808366eddd9d0fcc0797cc914e82705fed3c14347efab1917c539abea5d01386f3748c35481dbc89b3e85637fcbefcd1f1d214588b75a9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d4c24f92a5d42809ea8f9e42a16e00c5d7da34c8af671345c018b7811548ff7e6b7cd02a8a799f71c84b53fca0c2eb9d8e80ed1f8412cb3e0b7d76965bee98b0"} 22:19:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:19:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:19:53 INFO - Contents: 22:19:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/18f627f6def02bb8733f6afb947bf57c0812c96c0d428daf0ee0899d27d7d3c3b331e2f19ac26a922c7eef09ff90d8898ed3c1de8697b76066eba341af55b09d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/086e0ba477d728fb2c583f555cada795eb5f0be8136fcffbae305f8d6e0d5adbff29548aa81e45a7f53770f9ea00468a714a203ff502630fb4e08d393b7cc31b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c3b21ef8bc1020170a808366eddd9d0fcc0797cc914e82705fed3c14347efab1917c539abea5d01386f3748c35481dbc89b3e85637fcbefcd1f1d214588b75a9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d4c24f92a5d42809ea8f9e42a16e00c5d7da34c8af671345c018b7811548ff7e6b7cd02a8a799f71c84b53fca0c2eb9d8e80ed1f8412cb3e0b7d76965bee98b0"} 22:19:53 INFO - Running post-run listener: copy_logs_to_upload_dir 22:19:53 INFO - Copying logs to upload dir... 22:19:53 INFO - mkdir: /builds/slave/test/build/upload/logs 22:19:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.482416 ========= master_lag: 0.34 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-12-20 22:19:53.572705) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-20 22:19:53.577654) ========= 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.qa0W2EkVgN/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.9XdGcrC4mF/Listeners TMPDIR=/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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/18f627f6def02bb8733f6afb947bf57c0812c96c0d428daf0ee0899d27d7d3c3b331e2f19ac26a922c7eef09ff90d8898ed3c1de8697b76066eba341af55b09d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/086e0ba477d728fb2c583f555cada795eb5f0be8136fcffbae305f8d6e0d5adbff29548aa81e45a7f53770f9ea00468a714a203ff502630fb4e08d393b7cc31b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c3b21ef8bc1020170a808366eddd9d0fcc0797cc914e82705fed3c14347efab1917c539abea5d01386f3748c35481dbc89b3e85637fcbefcd1f1d214588b75a9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d4c24f92a5d42809ea8f9e42a16e00c5d7da34c8af671345c018b7811548ff7e6b7cd02a8a799f71c84b53fca0c2eb9d8e80ed1f8412cb3e0b7d76965bee98b0"} build_url:https://queue.taskcluster.net/v1/task/DkyMu6TySlmVLmQyzgcaQg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011056 build_url: 'https://queue.taskcluster.net/v1/task/DkyMu6TySlmVLmQyzgcaQg/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/18f627f6def02bb8733f6afb947bf57c0812c96c0d428daf0ee0899d27d7d3c3b331e2f19ac26a922c7eef09ff90d8898ed3c1de8697b76066eba341af55b09d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/086e0ba477d728fb2c583f555cada795eb5f0be8136fcffbae305f8d6e0d5adbff29548aa81e45a7f53770f9ea00468a714a203ff502630fb4e08d393b7cc31b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c3b21ef8bc1020170a808366eddd9d0fcc0797cc914e82705fed3c14347efab1917c539abea5d01386f3748c35481dbc89b3e85637fcbefcd1f1d214588b75a9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d4c24f92a5d42809ea8f9e42a16e00c5d7da34c8af671345c018b7811548ff7e6b7cd02a8a799f71c84b53fca0c2eb9d8e80ed1f8412cb3e0b7d76965bee98b0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-20 22:19:53.611981) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 22:19:53.613967) ========= 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.qa0W2EkVgN/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.9XdGcrC4mF/Listeners TMPDIR=/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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.004732 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 22:19:53.661636) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-20 22:19:53.661901) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-20 22:19:53.662179) ========= ========= Total master_lag: 2.34 =========