builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0102 starttime: 1486603664.27 results: success (0) buildid: 20170208162021 builduid: 5c0705c268f24c61924ed2150060c653 revision: f505911eb333d5ae8c2bf5c44f7b85add6450b53 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-08 17:27:44.275239) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-08 17:27:44.275746) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-08 17:27:44.276312) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-08 17:27:44.304166) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 17:27:44.304532) ========= 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.IPiMkb0NBd/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.diNOcRojjn/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-08 17:27:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 168M=0s 2017-02-08 17:27:44 (168 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.123148 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 17:27:44.455264) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 17:27:44.455654) ========= 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.IPiMkb0NBd/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.diNOcRojjn/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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.028221 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 17:27:44.506180) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 17:27:44.506567) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f505911eb333d5ae8c2bf5c44f7b85add6450b53 --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 f505911eb333d5ae8c2bf5c44f7b85add6450b53 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.IPiMkb0NBd/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.diNOcRojjn/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-08 17:27:44,610 truncating revision to first 12 chars 2017-02-08 17:27:44,610 Setting DEBUG logging. 2017-02-08 17:27:44,610 attempt 1/10 2017-02-08 17:27:44,610 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f505911eb333?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-08 17:27:45,264 unpacking tar archive at: mozilla-central-f505911eb333/testing/mozharness/ program finished with exit code 0 elapsedTime=0.928091 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 17:27:45.461310) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-08 17:27:45.461708) ========= script_repo_revision: f505911eb333d5ae8c2bf5c44f7b85add6450b53 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-08 17:27:45.462161) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 3 secs) (at 2017-02-08 17:27:45.462482) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 3 secs) (at 2017-02-08 17:27:48.937042) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-02-08 17:27:48.937501) ========= /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.IPiMkb0NBd/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.diNOcRojjn/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 17:27:49 INFO - MultiFileLogger online at 20170208 17:27:49 in /builds/slave/test 17:27:49 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 17:27:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:27:49 INFO - {'append_to_log': False, 17:27:49 INFO - 'base_work_dir': '/builds/slave/test', 17:27:49 INFO - 'blob_upload_branch': 'Firefox', 17:27:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:27:49 INFO - 'branch': 'Firefox', 17:27:49 INFO - 'buildbot_json_path': 'buildprops.json', 17:27:49 INFO - 'config_files': ('talos/mac_config.py',), 17:27:49 INFO - 'default_actions': ('clobber', 17:27:49 INFO - 'read-buildbot-config', 17:27:49 INFO - 'download-and-extract', 17:27:49 INFO - 'populate-webroot', 17:27:49 INFO - 'create-virtualenv', 17:27:49 INFO - 'install', 17:27:49 INFO - 'run-tests'), 17:27:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:27:49 INFO - 'download_minidump_stackwalk': True, 17:27:49 INFO - 'download_symbols': 'ondemand', 17:27:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:27:49 INFO - 'tooltool.py': '/tools/tooltool.py', 17:27:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:27:49 INFO - '/tools/misc-python/virtualenv.py')}, 17:27:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:27:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:27:49 INFO - 'installer_path': 'installer.exe', 17:27:49 INFO - 'log_level': 'info', 17:27:49 INFO - 'log_name': 'talos', 17:27:49 INFO - 'log_to_console': True, 17:27:49 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:27:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:27:49 INFO - 'opt_config_files': (), 17:27:49 INFO - 'pip_index': False, 17:27:49 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:27:49 INFO - 'cmd': ('bash', 17:27:49 INFO - '-c', 17:27:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:27:49 INFO - 'enabled': True, 17:27:49 INFO - 'halt_on_failure': False, 17:27:49 INFO - 'name': 'check_screen_resolution'},), 17:27:49 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:27:49 INFO - 'cmd': ('bash', 17:27:49 INFO - '-c', 17:27:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:27:49 INFO - 'enabled': True, 17:27:49 INFO - 'halt_on_failure': False, 17:27:49 INFO - 'name': 'check_screen_resolution'},), 17:27:49 INFO - 'run_cmd_checks_enabled': True, 17:27:49 INFO - 'sps_profile': False, 17:27:49 INFO - 'sps_profile_interval': 0, 17:27:49 INFO - 'suite': 'dromaeojs', 17:27:49 INFO - 'system_bits': '32', 17:27:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:27:49 INFO - 'title': 't-yosemite-r7-0102', 17:27:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:27:49 INFO - 'use_talos_json': True, 17:27:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:27:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:27:49 INFO - 'work_dir': 'build'} 17:27:49 INFO - [mozharness: 2017-02-09 01:27:49.154489Z] Running clobber step. 17:27:49 INFO - Running pre-action listener: _resource_record_pre_action 17:27:49 INFO - Running main action method: clobber 17:27:49 INFO - rmtree: /builds/slave/test/build 17:27:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:27:51 INFO - Running post-action listener: _resource_record_post_action 17:27:51 INFO - [mozharness: 2017-02-09 01:27:51.645962Z] Finished clobber step (success) 17:27:51 INFO - [mozharness: 2017-02-09 01:27:51.646164Z] Running read-buildbot-config step. 17:27:51 INFO - Running pre-action listener: _resource_record_pre_action 17:27:51 INFO - Running main action method: read_buildbot_config 17:27:51 INFO - Using buildbot properties: 17:27:51 INFO - { 17:27:51 INFO - "project": "", 17:27:51 INFO - "product": "firefox", 17:27:51 INFO - "script_repo_revision": "production", 17:27:51 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 17:27:51 INFO - "repository": "", 17:27:51 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 17:27:51 INFO - "buildid": "20170208162021", 17:27:51 INFO - "pgo_build": "False", 17:27:51 INFO - "basedir": "/builds/slave/test", 17:27:51 INFO - "buildnumber": 130, 17:27:51 INFO - "slavename": "t-yosemite-r7-0102", 17:27:51 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 17:27:51 INFO - "platform": "yosemite_r7", 17:27:51 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 17:27:51 INFO - "branch": "mozilla-central", 17:27:51 INFO - "repo_path": "mozilla-central", 17:27:51 INFO - "revision": "f505911eb333d5ae8c2bf5c44f7b85add6450b53", 17:27:51 INFO - "stage_platform": "macosx64", 17:27:51 INFO - "builduid": "5c0705c268f24c61924ed2150060c653", 17:27:51 INFO - "slavebuilddir": "test" 17:27:51 INFO - } 17:27:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/A86S5OApR0GkSKaMweJNtQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 17:27:51 INFO - Running post-action listener: _resource_record_post_action 17:27:51 INFO - [mozharness: 2017-02-09 01:27:51.651974Z] Finished read-buildbot-config step (success) 17:27:51 INFO - [mozharness: 2017-02-09 01:27:51.652177Z] Running download-and-extract step. 17:27:51 INFO - Running pre-action listener: _resource_record_pre_action 17:27:51 INFO - Running main action method: download_and_extract 17:27:51 INFO - mkdir: /builds/slave/test/build/tests 17:27:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:27:51 INFO - trying https://queue.taskcluster.net/v1/task/A86S5OApR0GkSKaMweJNtQ/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 17:27:51 INFO - Downloading https://queue.taskcluster.net/v1/task/A86S5OApR0GkSKaMweJNtQ/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 17:27:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A86S5OApR0GkSKaMweJNtQ/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 17:27:52 INFO - Downloaded 1199 bytes. 17:27:52 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 17:27:52 INFO - Using the following test package requirements: 17:27:52 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 17:27:52 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 17:27:52 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 17:27:52 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 17:27:52 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 17:27:52 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 17:27:52 INFO - u'jsshell-mac.zip'], 17:27:52 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 17:27:52 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 17:27:52 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 17:27:52 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 17:27:52 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 17:27:52 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 17:27:52 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 17:27:52 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 17:27:52 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 17:27:52 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 17:27:52 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 17:27:52 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:27:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A86S5OApR0GkSKaMweJNtQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 17:27:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A86S5OApR0GkSKaMweJNtQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:27:52 INFO - Fetch https://queue.taskcluster.net/v1/task/A86S5OApR0GkSKaMweJNtQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 17:27:53 INFO - Expected file size: 34938722 17:27:53 INFO - Obtained file size: 34938722 17:28:00 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 17:28:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A86S5OApR0GkSKaMweJNtQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 17:28:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A86S5OApR0GkSKaMweJNtQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:28:00 INFO - Fetch https://queue.taskcluster.net/v1/task/A86S5OApR0GkSKaMweJNtQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 17:28:02 INFO - Expected file size: 34938722 17:28:02 INFO - Obtained file size: 34938722 17:28:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A86S5OApR0GkSKaMweJNtQ/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 17:28:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A86S5OApR0GkSKaMweJNtQ/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 17:28:08 INFO - Fetch https://queue.taskcluster.net/v1/task/A86S5OApR0GkSKaMweJNtQ/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 17:28:10 INFO - Expected file size: 14403454 17:28:10 INFO - Obtained file size: 14403454 17:28:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:28:10 INFO - trying https://queue.taskcluster.net/v1/task/A86S5OApR0GkSKaMweJNtQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 17:28:10 INFO - Downloading https://queue.taskcluster.net/v1/task/A86S5OApR0GkSKaMweJNtQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 17:28:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A86S5OApR0GkSKaMweJNtQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 17:28:12 INFO - Downloaded 70305105 bytes. 17:28:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A86S5OApR0GkSKaMweJNtQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 17:28:12 INFO - mkdir: /builds/slave/test/properties 17:28:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:28:12 INFO - Writing to file /builds/slave/test/properties/build_url 17:28:12 INFO - Contents: 17:28:12 INFO - build_url:https://queue.taskcluster.net/v1/task/A86S5OApR0GkSKaMweJNtQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 17:28:13 INFO - Running post-action listener: _resource_record_post_action 17:28:13 INFO - Running post-action listener: set_extra_try_arguments 17:28:13 INFO - [mozharness: 2017-02-09 01:28:13.000927Z] Finished download-and-extract step (success) 17:28:13 INFO - [mozharness: 2017-02-09 01:28:13.001084Z] Running populate-webroot step. 17:28:13 INFO - Running pre-action listener: _resource_record_pre_action 17:28:13 INFO - Running main action method: populate_webroot 17:28:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:28:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:28:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:28:13 INFO - '--tppagecycles', 17:28:13 INFO - '7'], 17:28:13 INFO - 'tests': ['tsvgm']}}, 17:28:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:28:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:28:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:28:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:28:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:28:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:28:13 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:28:13 INFO - 'talos_options': ['--disable-e10s'], 17:28:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:28:13 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:28:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:28:13 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:28:13 INFO - 'talos_options': ['--disable-e10s'], 17:28:13 INFO - 'tests': ['damp', 'tps']}, 17:28:13 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:28:13 INFO - 'tests': ['damp', 'tps']}, 17:28:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:28:13 INFO - 'tests': ['dromaeo_dom']}, 17:28:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:28:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:28:13 INFO - 'tests': ['basic_compositor_video']}, 17:28:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:28:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:28:13 INFO - 'tests': ['a11yr', 17:28:13 INFO - 'ts_paint', 17:28:13 INFO - 'tpaint', 17:28:13 INFO - 'sessionrestore', 17:28:13 INFO - 'sessionrestore_no_auto_restore', 17:28:13 INFO - 'tabpaint']}, 17:28:13 INFO - 'other-e10s': {'tests': ['a11yr', 17:28:13 INFO - 'ts_paint', 17:28:13 INFO - 'tpaint', 17:28:13 INFO - 'sessionrestore', 17:28:13 INFO - 'sessionrestore_no_auto_restore', 17:28:13 INFO - 'tabpaint']}, 17:28:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:28:13 INFO - 'ts_paint', 17:28:13 INFO - 'tpaint', 17:28:13 INFO - 'sessionrestore', 17:28:13 INFO - 'sessionrestore_no_auto_restore', 17:28:13 INFO - 'tabpaint']}, 17:28:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:28:13 INFO - 'ts_paint', 17:28:13 INFO - 'tpaint', 17:28:13 INFO - 'sessionrestore', 17:28:13 INFO - 'sessionrestore_no_auto_restore', 17:28:13 INFO - 'tabpaint']}, 17:28:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:28:13 INFO - 'tests': ['a11yr', 17:28:13 INFO - 'ts_paint', 17:28:13 INFO - 'tpaint', 17:28:13 INFO - 'sessionrestore', 17:28:13 INFO - 'sessionrestore_no_auto_restore', 17:28:13 INFO - 'tabpaint']}, 17:28:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:28:13 INFO - 'tests': ['a11yr', 17:28:13 INFO - 'ts_paint', 17:28:13 INFO - 'tpaint', 17:28:13 INFO - 'sessionrestore', 17:28:13 INFO - 'sessionrestore_no_auto_restore', 17:28:13 INFO - 'tabpaint']}, 17:28:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:28:13 INFO - 'tests': ['tsvgx', 17:28:13 INFO - 'tsvgr_opacity', 17:28:13 INFO - 'tart', 17:28:13 INFO - 'tscrollx', 17:28:13 INFO - 'cart', 17:28:13 INFO - 'tsvg_static']}, 17:28:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:28:13 INFO - 'tsvgr_opacity', 17:28:13 INFO - 'tart', 17:28:13 INFO - 'tscrollx', 17:28:13 INFO - 'cart', 17:28:13 INFO - 'tsvg_static']}, 17:28:13 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:28:13 INFO - 'talos_options': ['--disable-e10s'], 17:28:13 INFO - 'tests': ['tp5o']}, 17:28:13 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:28:13 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:28:13 INFO - 'talos_options': ['--disable-e10s', 17:28:13 INFO - '--xperf_path', 17:28:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:28:13 INFO - 'tests': ['tp5n']}, 17:28:13 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:28:13 INFO - 'talos_options': ['--xperf_path', 17:28:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:28:13 INFO - 'tests': ['tp5n']}}, 17:28:13 INFO - 'talos.zip': {'path': '', 17:28:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:28:13 INFO - Running post-action listener: _resource_record_post_action 17:28:13 INFO - [mozharness: 2017-02-09 01:28:13.019533Z] Finished populate-webroot step (success) 17:28:13 INFO - [mozharness: 2017-02-09 01:28:13.019669Z] Running create-virtualenv step. 17:28:13 INFO - Running pre-action listener: _resource_record_pre_action 17:28:13 INFO - Running main action method: create_virtualenv 17:28:13 INFO - Creating virtualenv /builds/slave/test/build/venv 17:28:13 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 17:28:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:28:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:28:13 INFO - Using real prefix '/tools/python27' 17:28:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:28:13 INFO - Installing distribute.............................................................................................................................................................................................done. 17:28:16 INFO - Installing pip.................done. 17:28:16 INFO - Return code: 0 17:28:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:28:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:28:17 INFO - Reading from file tmpfile_stdout 17:28:17 INFO - Output received: 17:28:17 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) 17:28:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:28: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')]} 17:28:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:28:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28: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')]} 17:28:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:28:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102bccb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102bcf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3f9dce010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029aad30>, '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 0x1028d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10299fbe8>, '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.IPiMkb0NBd/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.diNOcRojjn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 17:28: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', 'pip>=1.5'] in /builds/slave/test/build 17:28: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 pip>=1.5 17:28:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IPiMkb0NBd/Render', 17:28:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:28:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:28:17 INFO - 'HOME': '/Users/cltbld', 17:28:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:28:17 INFO - 'LOGNAME': 'cltbld', 17:28:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:17 INFO - 'MOZ_NO_REMOTE': '1', 17:28:17 INFO - 'NO_EM_RESTART': '1', 17:28:17 INFO - 'PAGER': '/bin/cat', 17:28:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:28:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:17 INFO - 'PWD': '/builds/slave/test', 17:28:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:28:17 INFO - 'SHELL': '/bin/bash', 17:28:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.diNOcRojjn/Listeners', 17:28:17 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 17:28:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:28:17 INFO - 'USER': 'cltbld', 17:28:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:28:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:28:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:17 INFO - 'XPC_FLAGS': '0x0', 17:28:17 INFO - 'XPC_SERVICE_NAME': '0', 17:28:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:28:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:28:17 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 17:28:17 INFO - Cleaning up... 17:28:17 INFO - Return code: 0 17:28:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:28: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')]} 17:28:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:28:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28: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')]} 17:28:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:28:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28: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', '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 0x102bccb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102bcf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3f9dce010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029aad30>, '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 0x1028d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10299fbe8>, '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.IPiMkb0NBd/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.diNOcRojjn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 17:28: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', 'psutil>=3.1.1'] in /builds/slave/test/build 17:28: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 psutil>=3.1.1 17:28:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IPiMkb0NBd/Render', 17:28:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:28:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:28:17 INFO - 'HOME': '/Users/cltbld', 17:28:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:28:17 INFO - 'LOGNAME': 'cltbld', 17:28:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:17 INFO - 'MOZ_NO_REMOTE': '1', 17:28:17 INFO - 'NO_EM_RESTART': '1', 17:28:17 INFO - 'PAGER': '/bin/cat', 17:28:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:28:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:17 INFO - 'PWD': '/builds/slave/test', 17:28:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:28:17 INFO - 'SHELL': '/bin/bash', 17:28:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.diNOcRojjn/Listeners', 17:28:17 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 17:28:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:28:17 INFO - 'USER': 'cltbld', 17:28:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:28:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:28:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:17 INFO - 'XPC_FLAGS': '0x0', 17:28:17 INFO - 'XPC_SERVICE_NAME': '0', 17:28:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:28:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:28:17 INFO - Downloading/unpacking psutil>=3.1.1 17:28:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:28:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:28:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:28:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:28:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:28:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:28:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:28:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:28:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:28:21 INFO - Installing collected packages: psutil 17:28:21 INFO - Running setup.py install for psutil 17:28:21 INFO - building 'psutil._psutil_osx' extension 17:28:21 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 17:28:21 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 17:28:21 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 17:28:22 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 17:28:22 INFO - building 'psutil._psutil_posix' extension 17:28:22 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 17:28:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:28:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:28:22 INFO - ^ 17:28:22 INFO - 1 warning generated. 17:28:22 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 17:28:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:28:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:28:22 INFO - Successfully installed psutil 17:28:22 INFO - Cleaning up... 17:28:22 INFO - Return code: 0 17:28:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:28:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:28:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:28:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:28:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:28:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:22 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 0x102bccb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102bcf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3f9dce010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029aad30>, '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 0x1028d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10299fbe8>, '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.IPiMkb0NBd/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.diNOcRojjn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 17:28:22 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 17:28:22 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 17:28:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IPiMkb0NBd/Render', 17:28:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:28:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:28:22 INFO - 'HOME': '/Users/cltbld', 17:28:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:28:22 INFO - 'LOGNAME': 'cltbld', 17:28:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:22 INFO - 'MOZ_NO_REMOTE': '1', 17:28:22 INFO - 'NO_EM_RESTART': '1', 17:28:22 INFO - 'PAGER': '/bin/cat', 17:28:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:28:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:22 INFO - 'PWD': '/builds/slave/test', 17:28:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:28:22 INFO - 'SHELL': '/bin/bash', 17:28:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.diNOcRojjn/Listeners', 17:28:22 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 17:28:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:28:22 INFO - 'USER': 'cltbld', 17:28:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:28:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:28:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:22 INFO - 'XPC_FLAGS': '0x0', 17:28:22 INFO - 'XPC_SERVICE_NAME': '0', 17:28:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:28:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:28:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:28:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:28:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:28:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:28:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:28:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:28:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:28:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:28:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:28:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:28:25 INFO - Installing collected packages: mozsystemmonitor 17:28:25 INFO - Running setup.py install for mozsystemmonitor 17:28:25 INFO - Successfully installed mozsystemmonitor 17:28:25 INFO - Cleaning up... 17:28:25 INFO - Return code: 0 17:28:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:28: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')]} 17:28:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:28:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28: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')]} 17:28:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:28:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28: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', '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 0x102bccb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102bcf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3f9dce010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029aad30>, '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 0x1028d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10299fbe8>, '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.IPiMkb0NBd/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.diNOcRojjn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 17:28: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:28: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 jsonschema==2.5.1 17:28:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IPiMkb0NBd/Render', 17:28:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:28:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:28:25 INFO - 'HOME': '/Users/cltbld', 17:28:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:28:25 INFO - 'LOGNAME': 'cltbld', 17:28:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:25 INFO - 'MOZ_NO_REMOTE': '1', 17:28:25 INFO - 'NO_EM_RESTART': '1', 17:28:25 INFO - 'PAGER': '/bin/cat', 17:28:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:28:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:25 INFO - 'PWD': '/builds/slave/test', 17:28:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:28:25 INFO - 'SHELL': '/bin/bash', 17:28:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.diNOcRojjn/Listeners', 17:28:25 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 17:28:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:28:25 INFO - 'USER': 'cltbld', 17:28:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:28:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:28:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:25 INFO - 'XPC_FLAGS': '0x0', 17:28:25 INFO - 'XPC_SERVICE_NAME': '0', 17:28:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:28:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:28:25 INFO - Downloading/unpacking jsonschema==2.5.1 17:28: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 17:28: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 17:28: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 17:28: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 17:28: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 17:28: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 17:28:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:28:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:28: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 17:28: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 17:28: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 17:28: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 17:28: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 17:28: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 17:28:28 INFO - Downloading functools32-3.2.3-2.tar.gz 17:28:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:28:29 INFO - warning: no files found matching '*.txt' 17:28:29 INFO - no previously-included directories found matching 'build' 17:28:29 INFO - no previously-included directories found matching 'dist' 17:28:29 INFO - no previously-included directories found matching '.git*' 17:28:29 INFO - Installing collected packages: jsonschema, functools32 17:28:29 INFO - Running setup.py install for functools32 17:28:29 INFO - warning: no files found matching '*.txt' 17:28:29 INFO - no previously-included directories found matching 'build' 17:28:29 INFO - no previously-included directories found matching 'dist' 17:28:29 INFO - no previously-included directories found matching '.git*' 17:28:29 INFO - Successfully installed jsonschema functools32 17:28:29 INFO - Cleaning up... 17:28:29 INFO - Return code: 0 17:28:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:28:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:28:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:28:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:28:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:28:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:29 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 0x102bccb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102bcf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3f9dce010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029aad30>, '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 0x1028d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10299fbe8>, '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.IPiMkb0NBd/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.diNOcRojjn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 17:28:29 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 17:28:29 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 17:28:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IPiMkb0NBd/Render', 17:28:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:28:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:28:29 INFO - 'HOME': '/Users/cltbld', 17:28:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:28:29 INFO - 'LOGNAME': 'cltbld', 17:28:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:29 INFO - 'MOZ_NO_REMOTE': '1', 17:28:29 INFO - 'NO_EM_RESTART': '1', 17:28:29 INFO - 'PAGER': '/bin/cat', 17:28:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:28:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:29 INFO - 'PWD': '/builds/slave/test', 17:28:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:28:29 INFO - 'SHELL': '/bin/bash', 17:28:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.diNOcRojjn/Listeners', 17:28:29 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 17:28:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:28:29 INFO - 'USER': 'cltbld', 17:28:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:28:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:28:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:29 INFO - 'XPC_FLAGS': '0x0', 17:28:29 INFO - 'XPC_SERVICE_NAME': '0', 17:28:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:28:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:28:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:28:29 INFO - Cleaning up... 17:28:29 INFO - Return code: 0 17:28:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:28:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:28:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:28:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:28:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:28:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:29 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 0x102bccb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102bcf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3f9dce010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029aad30>, '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 0x1028d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10299fbe8>, '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.IPiMkb0NBd/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.diNOcRojjn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 17:28:29 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 17:28:29 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 17:28:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IPiMkb0NBd/Render', 17:28:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:28:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:28:29 INFO - 'HOME': '/Users/cltbld', 17:28:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:28:29 INFO - 'LOGNAME': 'cltbld', 17:28:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:29 INFO - 'MOZ_NO_REMOTE': '1', 17:28:29 INFO - 'NO_EM_RESTART': '1', 17:28:29 INFO - 'PAGER': '/bin/cat', 17:28:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:28:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:29 INFO - 'PWD': '/builds/slave/test', 17:28:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:28:29 INFO - 'SHELL': '/bin/bash', 17:28:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.diNOcRojjn/Listeners', 17:28:29 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 17:28:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:28:29 INFO - 'USER': 'cltbld', 17:28:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:28:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:28:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:29 INFO - 'XPC_FLAGS': '0x0', 17:28:29 INFO - 'XPC_SERVICE_NAME': '0', 17:28:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:28:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:28:29 INFO - Downloading/unpacking blobuploader==1.2.4 17:28:29 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 17:28:29 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 17:28:29 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 17:28:29 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 17:28:29 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 17:28:29 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 17:28:32 INFO - Downloading blobuploader-1.2.4.tar.gz 17:28:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:28:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:28:32 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 17:28:32 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 17:28:32 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 17:28:32 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 17:28:32 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 17:28:32 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 17:28:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:28:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:28:33 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 17:28:33 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 17:28:33 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 17:28:33 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 17:28:33 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 17:28:33 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 17:28:33 INFO - Downloading docopt-0.6.1.tar.gz 17:28:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:28:33 INFO - Installing collected packages: blobuploader, requests, docopt 17:28:33 INFO - Running setup.py install for blobuploader 17:28:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:28:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:28:34 INFO - Running setup.py install for requests 17:28:34 INFO - Running setup.py install for docopt 17:28:34 INFO - Successfully installed blobuploader requests docopt 17:28:34 INFO - Cleaning up... 17:28:34 INFO - Return code: 0 17:28:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:28:34 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')]} 17:28:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:28:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:34 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')]} 17:28:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:28:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:34 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 0x102bccb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102bcf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3f9dce010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029aad30>, '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 0x1028d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10299fbe8>, '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.IPiMkb0NBd/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.diNOcRojjn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 17:28:34 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 17:28:34 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 17:28:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IPiMkb0NBd/Render', 17:28:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:28:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:28:34 INFO - 'HOME': '/Users/cltbld', 17:28:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:28:34 INFO - 'LOGNAME': 'cltbld', 17:28:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:34 INFO - 'MOZ_NO_REMOTE': '1', 17:28:34 INFO - 'NO_EM_RESTART': '1', 17:28:34 INFO - 'PAGER': '/bin/cat', 17:28:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:28:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:34 INFO - 'PWD': '/builds/slave/test', 17:28:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:28:34 INFO - 'SHELL': '/bin/bash', 17:28:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.diNOcRojjn/Listeners', 17:28:34 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 17:28:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:28:34 INFO - 'USER': 'cltbld', 17:28:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:28:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:28:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:34 INFO - 'XPC_FLAGS': '0x0', 17:28:34 INFO - 'XPC_SERVICE_NAME': '0', 17:28:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:28:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:28:35 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-Ahx6IN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:28:35 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-h9ExQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:28:35 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-0gMnjL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:28:35 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-Y1bfsM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:28:35 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-wgJebm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:28:35 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-Hy8SMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:28:35 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-xUSPtH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:28:35 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-zrVkzy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:28:35 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-rKre4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:28:36 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-rp2o0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:28:36 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-dP3JA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:28:36 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-uXUKBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:28:36 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-Io9Kb6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:28:36 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-1G1C__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:28:36 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-vCdXrR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:28:36 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-EZp3XO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:28:36 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-Qn87cu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:28:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:28:36 INFO - Running setup.py install for manifestparser 17:28:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:28:37 INFO - Running setup.py install for mozcrash 17:28:37 INFO - Running setup.py install for mozdebug 17:28:37 INFO - Running setup.py install for mozdevice 17:28:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:28:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:28:37 INFO - Running setup.py install for mozfile 17:28:37 INFO - Running setup.py install for mozhttpd 17:28:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:28:37 INFO - Running setup.py install for mozinfo 17:28:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:28:37 INFO - Running setup.py install for mozInstall 17:28:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:28:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:28:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:28:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:28:38 INFO - Running setup.py install for mozleak 17:28:38 INFO - Running setup.py install for mozlog 17:28:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:28:38 INFO - Running setup.py install for moznetwork 17:28:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:28:38 INFO - Running setup.py install for mozprocess 17:28:38 INFO - Running setup.py install for mozprofile 17:28:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:28:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:28:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:28:38 INFO - Running setup.py install for mozrunner 17:28:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:28:39 INFO - Running setup.py install for mozscreenshot 17:28:39 INFO - Running setup.py install for moztest 17:28:39 INFO - Running setup.py install for mozversion 17:28:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:28:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:28:39 INFO - Cleaning up... 17:28:39 INFO - Return code: 0 17:28:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:28:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:28:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:28:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:28:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:28:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:39 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 0x102bccb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102bcf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3f9dce010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029aad30>, '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 0x1028d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10299fbe8>, '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.IPiMkb0NBd/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.diNOcRojjn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 17:28:39 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 17:28:39 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 17:28:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IPiMkb0NBd/Render', 17:28:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:28:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:28:39 INFO - 'HOME': '/Users/cltbld', 17:28:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:28:39 INFO - 'LOGNAME': 'cltbld', 17:28:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:39 INFO - 'MOZ_NO_REMOTE': '1', 17:28:39 INFO - 'NO_EM_RESTART': '1', 17:28:39 INFO - 'PAGER': '/bin/cat', 17:28:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:28:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:39 INFO - 'PWD': '/builds/slave/test', 17:28:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:28:39 INFO - 'SHELL': '/bin/bash', 17:28:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.diNOcRojjn/Listeners', 17:28:39 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 17:28:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:28:39 INFO - 'USER': 'cltbld', 17:28:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:28:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:28:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:39 INFO - 'XPC_FLAGS': '0x0', 17:28:39 INFO - 'XPC_SERVICE_NAME': '0', 17:28:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:28:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:28:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:28:39 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-nNjBbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:28:39 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)) 17:28:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:28:39 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-GTPuXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:28:39 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)) 17:28:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:28:39 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-elDXez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:28:40 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)) 17:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:28:40 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-1qTTgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:28:40 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)) 17:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:28:40 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-6ZKTW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:28:40 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)) 17:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:28:40 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-miK0MB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:28:40 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)) 17:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:28:40 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-5nyKJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:28:40 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)) 17:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:28:40 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-FYnwZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:28:40 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)) 17:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:28:40 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-q0YxmY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:28:40 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)) 17:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:28:40 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-ydnHPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:28:40 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)) 17:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:28:40 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-U_1xER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:28:40 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)) 17:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:28:40 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-UbFpKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:28:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:28:41 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-WMmn82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:28:41 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)) 17:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:28:41 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-MCChIg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:28:41 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)) 17:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:28:41 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-eqjLPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:28:41 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)) 17:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:28:41 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-J5zvqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:28:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:28:41 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-cjMBTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:28:41 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)) 17:28:41 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)) 17:28:41 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)) 17:28:41 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)) 17:28:41 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)) 17:28:41 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)) 17:28:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:28:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:28:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:28:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:28:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:28:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:28:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:28:44 INFO - Downloading blessings-1.6.tar.gz 17:28:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:28:44 INFO - Installing collected packages: blessings 17:28:44 INFO - Running setup.py install for blessings 17:28:44 INFO - Successfully installed blessings 17:28:44 INFO - Cleaning up... 17:28:44 INFO - Return code: 0 17:28:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:28:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:28:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:28:45 INFO - Reading from file tmpfile_stdout 17:28:45 INFO - Current package versions: 17:28:45 INFO - blessings == 1.6 17:28:45 INFO - blobuploader == 1.2.4 17:28:45 INFO - docopt == 0.6.1 17:28:45 INFO - functools32 == 3.2.3-2 17:28:45 INFO - jsonschema == 2.5.1 17:28:45 INFO - manifestparser == 1.1 17:28:45 INFO - mozInstall == 1.12 17:28:45 INFO - mozcrash == 1.0 17:28:45 INFO - mozdebug == 0.1 17:28:45 INFO - mozdevice == 0.49 17:28:45 INFO - mozfile == 1.2 17:28:45 INFO - mozhttpd == 0.7 17:28:45 INFO - mozinfo == 0.9 17:28:45 INFO - mozleak == 0.1 17:28:45 INFO - mozlog == 3.4 17:28:45 INFO - moznetwork == 0.27 17:28:45 INFO - mozprocess == 0.24 17:28:45 INFO - mozprofile == 0.28 17:28:45 INFO - mozrunner == 6.13 17:28:45 INFO - mozscreenshot == 0.1 17:28:45 INFO - mozsystemmonitor == 0.3 17:28:45 INFO - moztest == 0.8 17:28:45 INFO - mozversion == 1.4 17:28:45 INFO - psutil == 3.1.1 17:28:45 INFO - requests == 1.2.3 17:28:45 INFO - wsgiref == 0.1.2 17:28:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:28:45 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')]} 17:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:28:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:45 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')]} 17:28:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:28:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:45 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 0x102bccb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102bcf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3f9dce010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029aad30>, '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 0x1028d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10299fbe8>, '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.IPiMkb0NBd/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.diNOcRojjn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 17:28:45 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 17:28:45 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 17:28:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IPiMkb0NBd/Render', 17:28:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:28:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:28:45 INFO - 'HOME': '/Users/cltbld', 17:28:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:28:45 INFO - 'LOGNAME': 'cltbld', 17:28:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:45 INFO - 'MOZ_NO_REMOTE': '1', 17:28:45 INFO - 'NO_EM_RESTART': '1', 17:28:45 INFO - 'PAGER': '/bin/cat', 17:28:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:28:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:45 INFO - 'PWD': '/builds/slave/test', 17:28:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:28:45 INFO - 'SHELL': '/bin/bash', 17:28:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.diNOcRojjn/Listeners', 17:28:45 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 17:28:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:28:45 INFO - 'USER': 'cltbld', 17:28:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:28:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:28:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:45 INFO - 'XPC_FLAGS': '0x0', 17:28:45 INFO - 'XPC_SERVICE_NAME': '0', 17:28:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:28:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:28:45 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)) 17:28:45 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)) 17:28:45 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)) 17:28:45 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)) 17:28:45 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)) 17:28:45 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)) 17:28:45 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)) 17:28:45 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)) 17:28:45 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)) 17:28:45 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)) 17:28:45 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)) 17:28:45 INFO - Cleaning up... 17:28:45 INFO - Return code: 0 17:28:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:28:45 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')]} 17:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:28:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:45 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')]} 17:28:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:28:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:45 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 0x102bccb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102bcf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3f9dce010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029aad30>, '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 0x1028d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10299fbe8>, '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.IPiMkb0NBd/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.diNOcRojjn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 17:28:45 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 17:28:45 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 17:28:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IPiMkb0NBd/Render', 17:28:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:28:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:28:45 INFO - 'HOME': '/Users/cltbld', 17:28:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:28:45 INFO - 'LOGNAME': 'cltbld', 17:28:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:45 INFO - 'MOZ_NO_REMOTE': '1', 17:28:45 INFO - 'NO_EM_RESTART': '1', 17:28:45 INFO - 'PAGER': '/bin/cat', 17:28:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:28:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:45 INFO - 'PWD': '/builds/slave/test', 17:28:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:28:45 INFO - 'SHELL': '/bin/bash', 17:28:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.diNOcRojjn/Listeners', 17:28:45 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 17:28:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:28:45 INFO - 'USER': 'cltbld', 17:28:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:28:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:28:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:45 INFO - 'XPC_FLAGS': '0x0', 17:28:45 INFO - 'XPC_SERVICE_NAME': '0', 17:28:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:28:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:28:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:28:45 INFO - Cleaning up... 17:28:45 INFO - Return code: 0 17:28:45 INFO - Running post-action listener: _resource_record_post_action 17:28:45 INFO - Running post-action listener: _start_resource_monitoring 17:28:45 INFO - Starting resource monitoring. 17:28:45 INFO - [mozharness: 2017-02-09 01:28:45.820008Z] Finished create-virtualenv step (success) 17:28:45 INFO - [mozharness: 2017-02-09 01:28:45.821005Z] Running install step. 17:28:45 INFO - Running pre-action listener: _resource_record_pre_action 17:28:45 INFO - Running main action method: install 17:28:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:28:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:28:46 INFO - Reading from file tmpfile_stdout 17:28:46 INFO - Detecting whether we're running mozinstall >=1.0... 17:28:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:28:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:28:46 INFO - Reading from file tmpfile_stdout 17:28:46 INFO - Output received: 17:28:46 INFO - Usage: mozinstall [options] installer 17:28:46 INFO - Options: 17:28:46 INFO - -h, --help show this help message and exit 17:28:46 INFO - -d DEST, --destination=DEST 17:28:46 INFO - Directory to install application into. [default: 17:28:46 INFO - "/builds/slave/test"] 17:28:46 INFO - --app=APP Application being installed. [default: firefox] 17:28:46 INFO - mkdir: /builds/slave/test/build/application 17:28:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:28:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 17:29:08 INFO - Reading from file tmpfile_stdout 17:29:08 INFO - Output received: 17:29:08 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:29:08 INFO - Running post-action listener: _resource_record_post_action 17:29:08 INFO - [mozharness: 2017-02-09 01:29:08.199754Z] Finished install step (success) 17:29:08 INFO - [mozharness: 2017-02-09 01:29:08.199895Z] Running run-tests step. 17:29:08 INFO - Running pre-action listener: _resource_record_pre_action 17:29:08 INFO - Running main action method: run_tests 17:29:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:29:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:29:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:29:08 INFO - 2017-02-08 17:29:08.214 screenresolution[1628:7291] starting screenresolution argv=screenresolution get 17:29:08 INFO - 2017-02-08 17:29:08.217 screenresolution[1628:7291] Display 0: 1600x1200x32@60 17:29:08 INFO - 2017-02-08 17:29:08.223 screenresolution[1629:7294] starting screenresolution argv=screenresolution list 17:29:08 INFO - Available Modes on Display 0 17:29:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:29:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:29:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:29:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:29:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:29:08 INFO - Intel Iris: 17:29:08 INFO - Chipset Model: Intel Iris 17:29:08 INFO - Type: GPU 17:29:08 INFO - Bus: Built-In 17:29:08 INFO - VRAM (Dynamic, Max): 1536 MB 17:29:08 INFO - Vendor: Intel (0x8086) 17:29:08 INFO - Device ID: 0x0a2e 17:29:08 INFO - Revision ID: 0x0009 17:29:08 INFO - Displays: 17:29:08 INFO - Display: 17:29:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:29:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:29:08 INFO - Display Serial Number: 1600x1200 60 17:29:08 INFO - Main Display: Yes 17:29:08 INFO - Mirror: Off 17:29:08 INFO - Online: Yes 17:29:08 INFO - Rotation: Supported 17:29:08 INFO - Return code: 0 17:29:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:29:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:29:08 INFO - Python 2.7.3 17:29:08 INFO - Return code: 0 17:29:08 INFO - grabbing minidump binary from tooltool 17:29:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:29:08 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 0x1029aad30>, '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 0x1028d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10299fbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:29:08 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 17:29:08 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 17:29:08 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 17:29:08 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:29:08 INFO - Return code: 0 17:29:08 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:29:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:29:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:29:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:29:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:29:08 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/A86S5OApR0GkSKaMweJNtQ/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0102', '--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 17:29:08 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/A86S5OApR0GkSKaMweJNtQ/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0102 --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 17:29:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IPiMkb0NBd/Render', 17:29:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:29:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:29:08 INFO - 'HOME': '/Users/cltbld', 17:29:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:29:08 INFO - 'LOGNAME': 'cltbld', 17:29:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:29:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:29:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:29:08 INFO - 'MOZ_NO_REMOTE': '1', 17:29:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:29:08 INFO - 'NO_EM_RESTART': '1', 17:29:08 INFO - 'PAGER': '/bin/cat', 17:29:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:29:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:29:08 INFO - 'PWD': '/builds/slave/test', 17:29:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:29:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:29:08 INFO - 'SHELL': '/bin/bash', 17:29:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.diNOcRojjn/Listeners', 17:29:08 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 17:29:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:29:08 INFO - 'USER': 'cltbld', 17:29:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:29:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:29:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:29:08 INFO - 'XPC_FLAGS': '0x0', 17:29:08 INFO - 'XPC_SERVICE_NAME': '0', 17:29:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:29:08 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/A86S5OApR0GkSKaMweJNtQ/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0102', '--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 17:29:08 INFO - mozversion application_buildid: 20170208162021 17:29:08 INFO - mozversion application_changeset: f505911eb333d5ae8c2bf5c44f7b85add6450b53 17:29:08 INFO - mozversion application_display_name: Nightly 17:29:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:29:08 INFO - mozversion application_name: Firefox 17:29:08 INFO - mozversion application_remotingname: firefox 17:29:08 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:29:08 INFO - mozversion application_vendor: Mozilla 17:29:08 INFO - mozversion application_version: 54.0a1 17:29:08 INFO - mozversion platform_buildid: 20170208162021 17:29:08 INFO - mozversion platform_changeset: f505911eb333d5ae8c2bf5c44f7b85add6450b53 17:29:08 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:29:08 INFO - mozversion platform_version: 54.0a1 17:29:08 INFO - using testdate: 1486603748 17:29:08 INFO - actual date: 1486603748 17:29:08 INFO - starting webserver on 'localhost:49241' 17:29:08 INFO - SUITE-START | Running 2 tests 17:29:08 INFO - TEST-START | dromaeo_css 17:29:08 INFO - operating with platform_type : mac_ 17:29:08 INFO - Initialising browser for dromaeo_css test... 17:29:08 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmpiJJnYE/profile http://localhost:49241/getInfo.html) 17:29:10 INFO - PROCESS | 1639 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 17:29:11 INFO - PROCESS | 1639 | __metrics Screen width/height:1600/1200 17:29:11 INFO - PROCESS | 1639 | colorDepth:24 17:29:11 INFO - PROCESS | 1639 | Browser inner width/height: 1024/689 17:29:11 INFO - PROCESS | 1639 | __metrics 17:29:11 INFO - PROCESS | 1639 | 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" 17:29:11 INFO - PROCESS | 1639 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:29:12 INFO - TEST-INFO | 1639: exit 0 17:29:12 INFO - Browser initialized. 17:29:12 INFO - Running cycle 1/1 for dromaeo_css test... 17:29:12 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmpiJJnYE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:29:24 INFO - PROCESS | 1641 | RSS: Main: 228159488 17:29:24 INFO - PROCESS | 1641 | 17:32:28 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 17:32:30 INFO - PROCESS | 1641 | RSS: Main: 376745984 17:32:30 INFO - PROCESS | 1641 | 17:34:13 INFO - PROCESS | 1641 | ************************* 17:34:13 INFO - PROCESS | 1641 | A coding exception was thrown and uncaught in a Task. 17:34:13 INFO - PROCESS | 1641 | 17:34:13 ERROR - PROCESS | 1641 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:34:13 INFO - PROCESS | 1641 | Full stack: 17:34:13 INFO - PROCESS | 1641 | ************************* 17:35:33 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 17:35:33 INFO - PROCESS | 1641 | RSS: Main: 374730752 17:35:33 INFO - PROCESS | 1641 | 17:38:36 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 17:38:36 INFO - PROCESS | 1641 | RSS: Main: 364879872 17:38:36 INFO - PROCESS | 1641 | 17:41:39 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 17:41:39 INFO - PROCESS | 1641 | RSS: Main: 357048320 17:41:39 INFO - PROCESS | 1641 | 17:44:43 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 17:44:43 INFO - PROCESS | 1641 | RSS: Main: 336764928 17:44:43 INFO - PROCESS | 1641 | 17:47:46 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 17:47:47 INFO - PROCESS | 1641 | RSS: Main: 434388992 17:47:47 INFO - PROCESS | 1641 | 17:47:47 INFO - PROCESS | 1641 | __start_tp_report 17:47:47 INFO - PROCESS | 1641 | _x_x_mozilla_page_load 17:47:47 INFO - PROCESS | 1641 | _x_x_mozilla_page_load_details 17:47:47 INFO - PROCESS | 1641 | |i|pagename|runs| 17:47:47 INFO - PROCESS | 1641 | |0;dojo.html;3313.4201514734914;3317.6184738755037;3318.153870762955;3342.364950659376;3384.746144039196;4539.841105561306;5408.972955135228;5549.361823390312;5589.86025349366;5619.522340601049;5536.944630553693;5540.833774986757;5572.60991730578;5586.24585680933;5653.462921022507;4970.70175789452;5048.318477005603;5052.166392545226;5161.0968080585935;5204.141316682742;5161.17421212606;5214.895702085956;5227.18978558324;5235.450277720842;5260.710660913648;4107.747137123176;4970.453250142481;4988.226824842155;5119.462456442076;5149.562287205592;5016.046951079284;5029.899402011939;5040.042391945519;5049.1416459201655;5056.924146137811;4446.955530444687;5011.173156429221;5018.021485810268;5040.34475518184;5094.974525127351;5534.557235421156;5555.8888822223735;5557.694326812024;5637.746301416446;5652.06740887753;6058.606190597641;6117.816465506042;6126.938730612681;6131.816045518642;6145.508359331243;5932.288125424977;5946.07835785454;5996.760129594811;6248.187735594389;6261.092141639482;5660.688662123582;5703;5709.257796486513;5724.112762521816;5739.339975902824;6272.341404152589;6307.9369206308265;6320.241571011508;6330.968345158337;6346.365363463617;5811.506021988093;5857.853553661107;5862.912056319158;6009.819705408845;6085.08723691441;6174.722137503823;6224.906626400608;6225.470834979077;6235.532335074888;6239.656818875005;6158.445739883432;6164.506839452923;6171.13604095427;6171.59884607499;6177.938220617736;5745.712714364348;5774.3070831499645;6197.96901015492;6199.442050215503;6202.596831205957;4820.566149046533;4901.828436004794;4945.7774400152075;4961.578265847444;4989.451160372429;4415.536368681306;4442.822287108479;4445.51099379068;4485.192665320208;4520.2089634314525;5544.944550554524;5619.241402410704;5625.212470254168;5627;5634.154876768517;6027.7287522061615;6089.69551522431;6095.512359011268;6146.385361463817;6215.378462153749;5583.190437386556;5650;5676.829695109153;5713.05734553794;5739.339975902742;5425.810096646598;5433.2936718227165;5440.863978400572;5441.7279136043835;5460.672359658353;6227.439530442282;6229.781957631551;6267.965785645318;6271.843203919847;6289.308176100534;5967.9701601491715;6001.009833377444;6002.669853157943;6110.5587591967305;6274.498040156868;6286.18279623646;6293.622382657055;6303.243610766737;6305.243370795534;6329.398707122816;6012.218411606463;6107.541934354852;6112.541559383153;6118.296395914527;6125.540584456273;5906.26171728534;5971.223740913653;6230.875382492234;6237.875242495215;6240.344763799736;5714.171445140349;5884.58807883444;5918.260217472816;5962.731677074456;6006.609570377911;5753.683547404766;5800.274965629296;5818.010938140611;5852.239208902815;5952.672603006876;4874.658773885794;5739.569532285179;5761.39505351932;5810.331811841692;5841.532677385884;5979.13302571116;5983.461488466059;5986.221791167294;5986.431289027535;5991.101334799815;5537.640053396516;5643;5656.745446454837;5700.800471983461;5717.456841600041 17:47:47 INFO - PROCESS | 1641 | |1;ext.html;458.639967625414;471.40132032318934;500.99300406183585;521.3300908332791;524.9553388756374;23369.415764605892;30573.847130764316;37180.628193718054;38798.030049248715;38933.41599876004;40308.79845600775;40671.79664101675;40749.38875916856;40833.795831020805;40870.795646021805;7776;8922.197002269795;9120.361574689774;9128.269738420944;9141.680041198559;7674.040744906887;10629.787404251949;10849.837252441219;10856.294340867858;10995.835062474029;10797.136229101652;10924.180686448548;10945.398003109825;11005.229633925628;11007.669769906915;7686.769396918102;7936.484128531627;10947.83578246327;11020.50407731654;11100.61147859821;10595.417252051135;10879.619213327496;10905.563777448893;10925.180611454094;10959.178061645409;38268.617313826784;38580;38615.84152475402;38740.225195495936;38750.80624596859;3224.9032529024166;3778.5087938568086;3781.2248489059953;3783.39465685489;3816.2382082527283;28532.572011419845;28662;29024;29042;29333.559996600066;3046.2688954650944;3074.815511069343;3099.9535006974916;3115.0873932872837;3133.4203172413177;300474;300643.49034764495;300956;301510;302867.9999999978;51040.489595104315;51283.487165128616;59903.10145347823;60901.69549152226;61499.6925015381;61477.38522614717;62672.68663656653;62943;65093.349066509676;65237.67381163064;14577.052491588012;14762.852371476149;14782.556523304318;14783.852161478248;14838.480653177086;11206.103511719206;11219.439028048564;11303.947934057758;11331.43342832855;11343.602973895873;14529.927350363181;15256.618584535254;16527.421540246032;16540.172991350384;16586.75119873203;6351.364863513611;6376.872462550723;6418.646974416359;6441.677916104176;6449.484041276686;795.836853445054;819.2749416766205;821.5194111444872;821.5809936932088;840.315143158324;27442.725572744417;28579.857100714362;28627;28740.99406520762;29622.703772962424;946.2808265718104;978.8629591857145;1019.3527110285022;1020.3265844542566;1035.9274850760373;14694.265286735621;14771.704565908622;14943.178125203001;15155;15237.238138093051;431445;487900;492129;492149;492585.53707231954;54896.725516372164;55063;55063.724681376334;55074.724626376614;55086;1310.233513394675;1345.18616237179;1345.9932700336435;1348.7976803479557;1355.3426588104762;27396.58905116385;27699.72300277052;28258.434831302846;28679.85280588753;29078.7092129076;47781;48010.51989480061;48208.517914820404;48321.7919552014;48497.75751121222;418931;422456;423514;423653;423697;37159.44260836144;37583;37623.43564846584;37646;37738.43392349062;42158.36762448627;42318.78840605777;42523.78738106413;42787;43643.78178109089;35012.47481287732;35130.47304290387;35364.46953295754;36012.4598131023;36260.81869590635;35018;35032.82483587668;36074.819625901706;36286.09284767902;36424.81787591045;34529.30941381108;34761.95714128479;34962.47556286708;35584.64415355813;35589.46615800817;29368.412631746818;29645.70354296516;30639.08082757521;30855.845720771253;30906.227344316572;22098.33704988853;22518.549629007;23068.4232894179;23156.536869262185;23474.765252347257 17:47:47 INFO - PROCESS | 1641 | |2;jquery.html;360.34956902790486;386.57669851512594;387.08261420433575;400.4753772557949;414.5150174296073;13742.587722368333;14218.360173792178;15099.849001509969;19969.700454493195;20100.396988090342;20203.39389818304;20408.69386959193;21035;21177.047032883518;21249.468763280925;5376.704281264529;5493.560515158788;5609.719514024282;5689.3172819261745;5703.74333155009;5565.3599836018975;5586.91619625706;5643.322801263834;5655.462731040545;5658.943410565883;3844.384898416254;4056.8174432150477;5631.1271752878365;5939.227900372945;6267.71795269214;6024.0662697282;6274.843128921791;6323.20959880015;6325.335839736807;6329.651869147195;5422.186671999192;5489.39616642169;5498.532624726903;5502.614816962814;5505.366882808488;23066.53866922669;25276;25354.49291014188;25450.618240726402;25635.74364256352;2469.876506174702;2524.1417917907997;2566.2557858221094;2581.5998520229396;2626.18588237645;9891.604335826558;9904.95047524765;10348.723280878196;13352.132111412728;14088.225147616877;1633.779439775627;1662.3267576631483;1805.3049575913237;1806.3406856497415;1816.7547381103514;129806;135305.32347338297;135657;138966.3051684735;139840.99999999898;11602.477888495037;11662.88337116618;11823.940880295715;11913.52345906154;12015.459304331325;13542.526011589547;15369.231538423033;15375.308111135026;15654.843451565339;15748.370065197263;7935.166807485246;8229.711960081368;8369.204925532065;8394.390412122724;8447.95776021116;7964.84070318602;7973.122956474783;8115.513069215748;8123.309518690978;8140.104588495261;4701.6003639690325;4785.832495862698;4796.8081276749235;4798.95201047992;4879.608991594093;1746.9825301747073;2011.8834047103705;2012.8087831655969;2048.9077991490417;2050.251658144766;944.6976967370513;992.4343124419012;1009.3035805294323;1017.0947856407803;1026.9422494830337;20626.65926714759;21185;21215.469613259484;21236.798511583456;21584.568308633738;986.2455221755363;1009.6769033909079;1031.9948400257952;1044.0968562193648;1059.2585190366774;10749.462526873625;10984.06635435981;11114.444277786079;11195.60815371458;11244.718882027852;622561;697123;709808;718641;726549;140978.2951085238;149256;150571;154486;155365;968.8934217236099;1005.5173516711873;1017.9236557258236;1023.2581378500528;1023.5087158163974;18632;19419.708704369164;19486.025698714722;19493.317733879812;19527.902360488108;57627.42372576221;57643.71178144083;57848.84302313846;58114.709426452595;58604;76965.2303476958;78991.60504197443;81193;83829.58085209534;84518;8165.836053445961;8386.203310685476;8460.196281353261;8470.364722645703;8664.696735614223;12293.56972505958;12918.806217906927;13058.281794501014;13447.932760336136;13585.932070339584;11156.051735602565;11236.93249141363;11458.94270528642;11634.88365116338;11729.41352932367;11236.550537978716;11390.37352945596;11404.714882128013;11503.02224310943;11751.706207344543;11297.604583839526;11475.770484590428;11530.711732206762;11554.248973816675;11841.23032002917;7293.708251669874;8209.876851847346;8397.110650103677;8413.158684131538;8511.95744021276;8221.298867336362;11114.944425277821;11197.44012799373;11281.492332844877;11442.970132688099 17:47:47 INFO - PROCESS | 1641 | |3;mootools.html;1251.4931452761632;1305.9682850548065;1386.5285802827036;1441.0849110814643;1452.1359790924403;7745.2641999010075;8111.91888081119;8117.797055073626;8121.959390203048;8134.959325203366;7884.881726774089;8155.714549990752;8208.83582328353;8341.833163336729;8345.83308333833;2042.5506388594486;2124.617568837609;2236.373815331706;2273.8067264282554;2278.9658155127686;1949.5516031312807;2226.7773222677765;2273.9772602274015;2274.920377786778;2276.226083131735;1987.1554589299562;2008.789077146893;2008.8694234874758;2010.4270282969358;2010.5174758058033;2181.901814418347;2254.8196144308417;2259.9096036158535;2260.8078313343385;2263.117384220164;1810.6650269700017;2247.955040899189;2251.1990407673798;2258.9947473374355;2260.6156953317977;8220.013598368234;8270.503769773773;8275.668973241063;8297.460665056751;8310.501369917823;5009.824656137054;5176;5188.844334669928;5193;5202.635815492879;2883.5674648802637;3232.337370838996;3395.2530443302435;3399.983000084984;3476.184290724496;1033.3541536539663;1046.6441409920662;1132.6729263427746;1165.81929800881;1195.5337418406828;10731.570737170503;10774.892251077466;10804.459777011196;10858.402787846666;10869.83695244572;3584.2473080652835;3704.9073773155887;4046.4941882264716;4243.575642435793;4463.107378524308;7223.241559636268;8395.328373730086;8414.663413463393;8553.871691924625;8592.312614990911;4279.87160385189;4908.239222920453;4912.828051018198;4914.705117692878;4940.90118197634;3903.7703123516003;4448.266036104072;4549.909001819945;4755.595774359149;4758.5241475852135;3537.3102245061964;3546.3261980223674;3564.7326450516316;3606.8376923038527;3621.311950729353;1121.9046381057537;1123.971900702489;1126.5606413498742;1136.8863113688565;1145.541783286692;742.907136607924;753.3144838197214;771.097815555801;779.7076096463826;799.4471484893592;5321.760520776575;5416.404195538487;5449.373322067933;5461.0716178249795;5555.194496798023;549.6564647095565;554.5064892245904;578.5458415144092;585.2508788750406;587.2189987316943;3591.712662986955;3626.437902125175;3679.392900171442;3740.925181496355;3757.3236817373136;9468.952655236817;9877.308588398886;9884.851727224097;9885.802283954281;9886.258530610234;9744.853827192597;9905.009499050182;9906.306558540833;9908.256880733974;9932.900670993198;7258.455615828834;7559.055118110236;7635.007449031701;7648.770536883902;7675;5327.254184414262;5590.189422533791;5677.403872593318;5710.5146062585145;5724.627899186539;8721.302295816446;8916.242119419921;9000.099990000948;9104.089591040844;9216.216621586971;9198.95400522993;9241.306901982243;9289.024652411399;9362.344635875696;9378.765530861783;6928.653567321513;7140.178879428932;7146.535475194096;7150.249223831631;7161.4628902831455;7685.884711729217;7692.269234422721;7704.152543220353;7707.11368192665;7784.688612455665;5672.546196304368;6980.476464265099;7054.894176587458;7093.255208203064;7155.785326440215;6770.187577490733;6949.930500695131;7015.508914375945;7065.682044307916;7071.611061391673;6179;6253.062040693932;6379.362063793584;6381.936180638134;6394.200724909387;4581.541845815392;4840.322354870392;4914.778834952364;4947.554720075211;4948.505149485023;4787.54518320759;4871.756412179306;4922.704637721748;4999.675021123615;5158.329417175743 17:47:47 INFO - PROCESS | 1641 | |4;prototype.html;297.2212802457561;309.33338655198025;345.74315676873414;361.85525789684124;362.57397557869496;4470.955290447095;4572.8399506017295;5291.629585928987;5300.549453296474;5331.546818520425;4421.960839202793;4927.663655982739;5074.517920797528;5109.237313126974;5186.662866913657;3626.4379021251684;3654.872079477219;3734.9813250933844;3938.547067087293;3963.1875465529497;3795.259924314746;3958.307296223164;3966.643002129808;3971;3997.380406037069;3598.4242521196484;3700.5946135012186;3933.193695292458;3950.723449358546;3958.366661334187;3728.5898551159353;3924.1759230561615;3940;3947.5262968443826;3959.089409435846;2894.8552572371295;3425.417678994552;3448.8100056464077;3451.6548345165534;3466.722662187019;4252.851150209759;4468.620167285784;4671.299305104228;5132.332796736438;5142.305788718512;3215.5015972524297;4187.801404262756;4327.805248763813;4443.644508439317;4542.545745425464;4623;4945.307656928033;5132.948670513321;5508.531774799147;5537.587915081669;3761.605031471711;3762.5861155272896;3778.3387907116144;3782.3569993101237;3789.7347185697013;4848.9757551212015;4885.36490256268;5279;5320.430473010471;5708.003298268401;3463.87876424329;3708.6053027162898;3774.6791522720328;3784.526934133233;3788.1476667749534;3840.30874442603;3843.0968722350226;3857.324968130566;3862.304785138702;3876.2828876657345;3787.5265591801026;4147.751134931914;4463;4528.637708983273;4534.682572219913;4456.373423700326;4722.409698787652;5247.63266571344;5250.579953603703;5593.496585307261;1052.4685034057752;1262.1228246368685;1281.5774490315741;1286.4498279573093;1301.8828305452555;747.2998927440009;855.9443636163629;857.8155696525278;858.7552547523926;866.0559989611354;4893.106893106893;4896.804127834918;4948.356713627278;4948.851534453972;4969.652124351261;4717.599004084623;4905.632077594195;5105;5282.841514754564;5450.3732070811575;4551.8350709100805;4897.608191344684;4925.38432695913;4928.732782919826;4935.90128197434;2427.3446169534127;2822.647169103862;2871.7128287171536;2897.4060317634835;2935.691752365971;5126.820561280412;5361.812336568201;5380.3274590676165;5671.8865622688145;5677.943220567741;4291.866937135846;5041.529650471242;5070.526689217824;5469.3983661797965;5568.916466253009;5405.270338479043;5422.755975981011;5529.147735508569;5628.690422026828;5648.898464799325;4842.7336496493035;5417.42894560573;5430.402655707948;5453.972730136324;5475.616706830484;4695.882602934954;4872.342233798392;4973.950260497493;5275.657082289639;5334.839954801362;4791.520847915181;4936.851894443173;5585.273914391103;5606.215129881902;5615.943840561542;2987;3388.5425467561563;3606.9098272542346;3626.0753507856384;3629.455581662666;4338.544452832533;4608.110674623388;4981.850544483671;5396.384422437055;5432.348118225838;4206.663466922578;4509.616682582017;4727.645426592951;4968;5187.325647665779;4428.402165707588;4818.95181048185;5065.189569668983;5239.175401956517;5242.921356179584;4158.812853421543;4238.3430568261965;4270.572942705705;4714.457837348748;5135.897282054413;4714.717116972993;4917.877053073702;5225.451327610698;5228.37259528859;5298.576113910801;4432.29083346663;5132.307138536399;5146.202338637517;5164.690118592896;5180.989707007248 17:47:47 INFO - PROCESS | 1641 | |5;yui.html;702.5117543307397;718.8095154783983;751.8383547537281;767.7773445700747;794.4200733464569;14203.715925681494;14895.92552037241;14916.62708432287;14949.925250373746;14954.700905981874;11980.940095299533;13066.542671006517;13139.605811825637;13281;13390.799138012913;858.9398742088056;864.5590748718137;864.6325311742515;870.3776799588293;873.1792115411524;865.1953683074738;865.4590880699562;866.3285953386113;866.33292364879;866.7053201911349;806.379088102161;859.6561375449808;859.6604341285189;909.8771665825128;910.4446287764458;901.0403919825364;901.2249465459699;902.3007169443669;904.1184844776291;904.3082042237694;659.993400065998;662.2384258103219;662.8541720821412;664.2659860853736;665.8235567574596;12316.692082698004;12595.748085038247;12706.174098683648;12751.489940402373;12795.424205910756;11475.254108482923;11516.96347328736;11594.188406811527;11709.355985420798;11992.460339284753;8391.958040209822;10112;10209.846852297222;10212.438315892623;10592.099671527929;3413.2832105257926;3482.199094208346;3485.2158264390564;3508;3512.7189824813954;96265;96485;96495;101247;102750;8477.279431248413;8494.277986371228;8575.95712021436;8614.87077693835;8716.311456221658;18532.722009169873;18768.436946891616;18773.1552080154;18805.059747012594;18853;6475.643839588868;7227.385672217921;7382.22486638906;7510.849783004419;7625.389968802482;3909.3745000799736;4101.26177288091;4121.505419349697;4165.875023749292;4175.331946888544;3372.544706464596;3429.34842379952;3450.7584469086923;3450.9482357764655;3469.028671971852;639.245690085694;643.32129603269;645.2643985856128;657.0932113683182;658.868226354731;618.703022549179;634.2357459261578;639.3798015924546;648.9513286503532;657.6054367379629;7285.526440781332;7922.960385198037;9190.770230744285;9657.501398769038;10829.350238985686;555.2143716640908;585.6954383720526;592.6710675575011;636.3413866647998;712.1383126417094;4515.887102822456;4819.855404337875;4838.346823178897;4841.464320190053;4925.21196608541;82461.58769206236;83440;86409.70385444224;89342;90102;70833.64583177051;74729;77453.45093098219;77909.83135252976;78497;65853.67073164604;67520.66239668771;69078.65460672765;73658;75867.62066189633;10343.338050197422;10675.733106672085;10744.140468762636;10961.12311015101;10976.780464390507;45793.77103114597;46658.53341466542;48402.273965889835;50509.74745126398;53314.4668553325;61703.38296616976;65107.69784604376;65516.672416637615;65702;65852.670736646;11009.889901100887;12452.68868278264;12856.871431285941;12858.164219325714;12952;14237.637600923965;14291.64270893236;14670.706585868436;14814.185219813015;15386.538403847902;13047.646009963206;13265.80101298462;13391.933040334736;13708.862911371158;13849.930750346184;10640.787184256425;13327.466901323838;13395.598132056053;13398.531051413154;13623.912826152313;12632.557860474839;12768.297743624189;13223.404946777611;13615.25116118623;13651.590452286448;10885.782284354427;11032.944835275772;11280.887191127984;11448.255863368855;11506.597269095542;8252.669893204205;10457.315104955422;10700.625478108228;10721.24951253436;10795.29830561011 17:47:47 INFO - PROCESS | 1641 | __end_tp_report 17:47:47 INFO - PROCESS | 1641 | __start_cc_report 17:47:47 INFO - PROCESS | 1641 | _x_x_mozilla_cycle_collect,1561 17:47:47 INFO - PROCESS | 1641 | __end_cc_report 17:47:47 INFO - PROCESS | 1641 | __startTimestamp1486604867013__endTimestamp 17:47:47 INFO - PROCESS | 1641 | 17:47:47 INFO - PROCESS | 1641 | ------- Summary: start ------- 17:47:47 INFO - PROCESS | 1641 | Number of tests: 6 17:47:47 INFO - PROCESS | 1641 | 17:47:47 INFO - PROCESS | 1641 | [#0] dojo.html Cycles:165 Average:5623.47 Median:5739.57 stddev:643.55 (11.2%) stddev-sans-first:619.48 17:47:47 INFO - PROCESS | 1641 | Values: 3313.4 3317.6 3318.2 3342.4 3384.7 4539.8 5409.0 5549.4 5589.9 5619.5 5536.9 5540.8 5572.6 5586.2 5653.5 4970.7 5048.3 5052.2 5161.1 5204.1 5161.2 5214.9 5227.2 5235.5 5260.7 4107.7 4970.5 4988.2 5119.5 5149.6 5016.0 5029.9 5040.0 5049.1 5056.9 4447.0 5011.2 5018.0 5040.3 5095.0 5534.6 5555.9 5557.7 5637.7 5652.1 6058.6 6117.8 6126.9 6131.8 6145.5 5932.3 5946.1 5996.8 6248.2 6261.1 5660.7 5703.0 5709.3 5724.1 5739.3 6272.3 6307.9 6320.2 6331.0 6346.4 5811.5 5857.9 5862.9 6009.8 6085.1 6174.7 6224.9 6225.5 6235.5 6239.7 6158.4 6164.5 6171.1 6171.6 6177.9 5745.7 5774.3 6198.0 6199.4 6202.6 4820.6 4901.8 4945.8 4961.6 4989.5 4415.5 4442.8 4445.5 4485.2 4520.2 5544.9 5619.2 5625.2 5627.0 5634.2 6027.7 6089.7 6095.5 6146.4 6215.4 5583.2 5650.0 5676.8 5713.1 5739.3 5425.8 5433.3 5440.9 5441.7 5460.7 6227.4 6229.8 6268.0 6271.8 6289.3 5968.0 6001.0 6002.7 6110.6 6274.5 6286.2 6293.6 6303.2 6305.2 6329.4 6012.2 6107.5 6112.5 6118.3 6125.5 5906.3 5971.2 6230.9 6237.9 6240.3 5714.2 5884.6 5918.3 5962.7 6006.6 5753.7 5800.3 5818.0 5852.2 5952.7 4874.7 5739.6 5761.4 5810.3 5841.5 5979.1 5983.5 5986.2 5986.4 5991.1 5537.6 5643.0 5656.7 5700.8 5717.5 17:47:47 INFO - PROCESS | 1641 | 17:47:47 INFO - PROCESS | 1641 | [#1] ext.html Cycles:180 Average:55262.16 Median:35474.56 stddev:108161.93 (304.9%) stddev-sans-first:108387.08 17:47:47 INFO - PROCESS | 1641 | Values: 458.6 471.4 501.0 521.3 525.0 23369.4 30573.8 37180.6 38798.0 38933.4 40308.8 40671.8 40749.4 40833.8 40870.8 7776.0 8922.2 9120.4 9128.3 9141.7 7674.0 10629.8 10849.8 10856.3 10995.8 10797.1 10924.2 10945.4 11005.2 11007.7 7686.8 7936.5 10947.8 11020.5 11100.6 10595.4 10879.6 10905.6 10925.2 10959.2 38268.6 38580.0 38615.8 38740.2 38750.8 3224.9 3778.5 3781.2 3783.4 3816.2 28532.6 28662.0 29024.0 29042.0 29333.6 3046.3 3074.8 3100.0 3115.1 3133.4 300474.0 300643.5 300956.0 301510.0 302868.0 51040.5 51283.5 59903.1 60901.7 61499.7 61477.4 62672.7 62943.0 65093.3 65237.7 14577.1 14762.9 14782.6 14783.9 14838.5 11206.1 11219.4 11303.9 11331.4 11343.6 14529.9 15256.6 16527.4 16540.2 16586.8 6351.4 6376.9 6418.6 6441.7 6449.5 795.8 819.3 821.5 821.6 840.3 27442.7 28579.9 28627.0 28741.0 29622.7 946.3 978.9 1019.4 1020.3 1035.9 14694.3 14771.7 14943.2 15155.0 15237.2 431445.0 487900.0 492129.0 492149.0 492585.5 54896.7 55063.0 55063.7 55074.7 55086.0 1310.2 1345.2 1346.0 1348.8 1355.3 27396.6 27699.7 28258.4 28679.9 29078.7 47781.0 48010.5 48208.5 48321.8 48497.8 418931.0 422456.0 423514.0 423653.0 423697.0 37159.4 37583.0 37623.4 37646.0 37738.4 42158.4 42318.8 42523.8 42787.0 43643.8 35012.5 35130.5 35364.5 36012.5 36260.8 35018.0 35032.8 36074.8 36286.1 36424.8 34529.3 34762.0 34962.5 35584.6 35589.5 29368.4 29645.7 30639.1 30855.8 30906.2 22098.3 22518.5 23068.4 23156.5 23474.8 17:47:47 INFO - PROCESS | 1641 | 17:47:47 INFO - PROCESS | 1641 | [#2] jquery.html Cycles:180 Average:39058.40 Median:21243.13 stddev:116316.89 (547.6%) stddev-sans-first:116606.89 17:47:47 INFO - PROCESS | 1641 | Values: 360.3 386.6 387.1 400.5 414.5 13742.6 14218.4 15099.8 19969.7 20100.4 20203.4 20408.7 21035.0 21177.0 21249.5 5376.7 5493.6 5609.7 5689.3 5703.7 5565.4 5586.9 5643.3 5655.5 5658.9 3844.4 4056.8 5631.1 5939.2 6267.7 6024.1 6274.8 6323.2 6325.3 6329.7 5422.2 5489.4 5498.5 5502.6 5505.4 23066.5 25276.0 25354.5 25450.6 25635.7 2469.9 2524.1 2566.3 2581.6 2626.2 9891.6 9905.0 10348.7 13352.1 14088.2 1633.8 1662.3 1805.3 1806.3 1816.8 129806.0 135305.3 135657.0 138966.3 139841.0 11602.5 11662.9 11823.9 11913.5 12015.5 13542.5 15369.2 15375.3 15654.8 15748.4 7935.2 8229.7 8369.2 8394.4 8448.0 7964.8 7973.1 8115.5 8123.3 8140.1 4701.6 4785.8 4796.8 4799.0 4879.6 1747.0 2011.9 2012.8 2048.9 2050.3 944.7 992.4 1009.3 1017.1 1026.9 20626.7 21185.0 21215.5 21236.8 21584.6 986.2 1009.7 1032.0 1044.1 1059.3 10749.5 10984.1 11114.4 11195.6 11244.7 622561.0 697123.0 709808.0 718641.0 726549.0 140978.3 149256.0 150571.0 154486.0 155365.0 968.9 1005.5 1017.9 1023.3 1023.5 18632.0 19419.7 19486.0 19493.3 19527.9 57627.4 57643.7 57848.8 58114.7 58604.0 76965.2 78991.6 81193.0 83829.6 84518.0 8165.8 8386.2 8460.2 8470.4 8664.7 12293.6 12918.8 13058.3 13447.9 13585.9 11156.1 11236.9 11458.9 11634.9 11729.4 11236.6 11390.4 11404.7 11503.0 11751.7 11297.6 11475.8 11530.7 11554.2 11841.2 7293.7 8209.9 8397.1 8413.2 8512.0 8221.3 11114.9 11197.4 11281.5 11443.0 17:47:47 INFO - PROCESS | 1641 | 17:47:47 INFO - PROCESS | 1641 | [#3] mootools.html Cycles:180 Average:5265.21 Median:5324.51 stddev:2948.30 (55.4%) stddev-sans-first:2941.14 17:47:47 INFO - PROCESS | 1641 | Values: 1251.5 1306.0 1386.5 1441.1 1452.1 7745.3 8111.9 8117.8 8122.0 8135.0 7884.9 8155.7 8208.8 8341.8 8345.8 2042.6 2124.6 2236.4 2273.8 2279.0 1949.6 2226.8 2274.0 2274.9 2276.2 1987.2 2008.8 2008.9 2010.4 2010.5 2181.9 2254.8 2259.9 2260.8 2263.1 1810.7 2248.0 2251.2 2259.0 2260.6 8220.0 8270.5 8275.7 8297.5 8310.5 5009.8 5176.0 5188.8 5193.0 5202.6 2883.6 3232.3 3395.3 3400.0 3476.2 1033.4 1046.6 1132.7 1165.8 1195.5 10731.6 10774.9 10804.5 10858.4 10869.8 3584.2 3704.9 4046.5 4243.6 4463.1 7223.2 8395.3 8414.7 8553.9 8592.3 4279.9 4908.2 4912.8 4914.7 4940.9 3903.8 4448.3 4549.9 4755.6 4758.5 3537.3 3546.3 3564.7 3606.8 3621.3 1121.9 1124.0 1126.6 1136.9 1145.5 742.9 753.3 771.1 779.7 799.4 5321.8 5416.4 5449.4 5461.1 5555.2 549.7 554.5 578.5 585.3 587.2 3591.7 3626.4 3679.4 3740.9 3757.3 9469.0 9877.3 9884.9 9885.8 9886.3 9744.9 9905.0 9906.3 9908.3 9932.9 7258.5 7559.1 7635.0 7648.8 7675.0 5327.3 5590.2 5677.4 5710.5 5724.6 8721.3 8916.2 9000.1 9104.1 9216.2 9199.0 9241.3 9289.0 9362.3 9378.8 6928.7 7140.2 7146.5 7150.2 7161.5 7685.9 7692.3 7704.2 7707.1 7784.7 5672.5 6980.5 7054.9 7093.3 7155.8 6770.2 6949.9 7015.5 7065.7 7071.6 6179.0 6253.1 6379.4 6381.9 6394.2 4581.5 4840.3 4914.8 4947.6 4948.5 4787.5 4871.8 4922.7 4999.7 5158.3 17:47:47 INFO - PROCESS | 1641 | 17:47:47 INFO - PROCESS | 1641 | [#4] prototype.html Cycles:180 Average:4252.86 Median:4714.59 stddev:1271.33 (27.0%) stddev-sans-first:1239.74 17:47:47 INFO - PROCESS | 1641 | Values: 297.2 309.3 345.7 361.9 362.6 4471.0 4572.8 5291.6 5300.5 5331.5 4422.0 4927.7 5074.5 5109.2 5186.7 3626.4 3654.9 3735.0 3938.5 3963.2 3795.3 3958.3 3966.6 3971.0 3997.4 3598.4 3700.6 3933.2 3950.7 3958.4 3728.6 3924.2 3940.0 3947.5 3959.1 2894.9 3425.4 3448.8 3451.7 3466.7 4252.9 4468.6 4671.3 5132.3 5142.3 3215.5 4187.8 4327.8 4443.6 4542.5 4623.0 4945.3 5132.9 5508.5 5537.6 3761.6 3762.6 3778.3 3782.4 3789.7 4849.0 4885.4 5279.0 5320.4 5708.0 3463.9 3708.6 3774.7 3784.5 3788.1 3840.3 3843.1 3857.3 3862.3 3876.3 3787.5 4147.8 4463.0 4528.6 4534.7 4456.4 4722.4 5247.6 5250.6 5593.5 1052.5 1262.1 1281.6 1286.4 1301.9 747.3 855.9 857.8 858.8 866.1 4893.1 4896.8 4948.4 4948.9 4969.7 4717.6 4905.6 5105.0 5282.8 5450.4 4551.8 4897.6 4925.4 4928.7 4935.9 2427.3 2822.6 2871.7 2897.4 2935.7 5126.8 5361.8 5380.3 5671.9 5677.9 4291.9 5041.5 5070.5 5469.4 5568.9 5405.3 5422.8 5529.1 5628.7 5648.9 4842.7 5417.4 5430.4 5454.0 5475.6 4695.9 4872.3 4974.0 5275.7 5334.8 4791.5 4936.9 5585.3 5606.2 5615.9 2987.0 3388.5 3606.9 3626.1 3629.5 4338.5 4608.1 4981.9 5396.4 5432.3 4206.7 4509.6 4727.6 4968.0 5187.3 4428.4 4819.0 5065.2 5239.2 5242.9 4158.8 4238.3 4270.6 4714.5 5135.9 4714.7 4917.9 5225.5 5228.4 5298.6 4432.3 5132.3 5146.2 5164.7 5181.0 17:47:47 INFO - PROCESS | 1641 | 17:47:47 INFO - PROCESS | 1641 | [#5] yui.html Cycles:180 Average:18663.16 Median:26620.31 stddev:26241.06 (98.6%) stddev-sans-first:26280.02 17:47:47 INFO - PROCESS | 1641 | Values: 702.5 718.8 751.8 767.8 794.4 14203.7 14895.9 14916.6 14949.9 14954.7 11980.9 13066.5 13139.6 13281.0 13390.8 858.9 864.6 864.6 870.4 873.2 865.2 865.5 866.3 866.3 866.7 806.4 859.7 859.7 909.9 910.4 901.0 901.2 902.3 904.1 904.3 660.0 662.2 662.9 664.3 665.8 12316.7 12595.7 12706.2 12751.5 12795.4 11475.3 11517.0 11594.2 11709.4 11992.5 8392.0 10112.0 10209.8 10212.4 10592.1 3413.3 3482.2 3485.2 3508.0 3512.7 96265.0 96485.0 96495.0 101247.0 102750.0 8477.3 8494.3 8576.0 8614.9 8716.3 18532.7 18768.4 18773.2 18805.1 18853.0 6475.6 7227.4 7382.2 7510.8 7625.4 3909.4 4101.3 4121.5 4165.9 4175.3 3372.5 3429.3 3450.8 3450.9 3469.0 639.2 643.3 645.3 657.1 658.9 618.7 634.2 639.4 649.0 657.6 7285.5 7923.0 9190.8 9657.5 10829.4 555.2 585.7 592.7 636.3 712.1 4515.9 4819.9 4838.3 4841.5 4925.2 82461.6 83440.0 86409.7 89342.0 90102.0 70833.6 74729.0 77453.5 77909.8 78497.0 65853.7 67520.7 69078.7 73658.0 75867.6 10343.3 10675.7 10744.1 10961.1 10976.8 45793.8 46658.5 48402.3 50509.7 53314.5 61703.4 65107.7 65516.7 65702.0 65852.7 11009.9 12452.7 12856.9 12858.2 12952.0 14237.6 14291.6 14670.7 14814.2 15386.5 13047.6 13265.8 13391.9 13708.9 13849.9 10640.8 13327.5 13395.6 13398.5 13623.9 12632.6 12768.3 13223.4 13615.3 13651.6 10885.8 11032.9 11280.9 11448.3 11506.6 8252.7 10457.3 10700.6 10721.2 10795.3 17:47:47 INFO - PROCESS | 1641 | -------- Summary: end -------- 17:47:47 INFO - PROCESS | 1641 | 17:47:47 INFO - TEST-INFO | 1641: exit 0 17:47:47 INFO - TEST-OK | dromaeo_css | took 1118828ms 17:47:47 INFO - TEST-START | kraken 17:47:47 INFO - operating with platform_type : mac_ 17:47:47 INFO - Initialising browser for kraken test... 17:47:47 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmpi_6vww/profile http://localhost:49241/getInfo.html) 17:47:49 INFO - PROCESS | 1651 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 17:47:50 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 17:47:50 INFO - PROCESS | 1651 | colorDepth:24 17:47:50 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 17:47:50 INFO - PROCESS | 1651 | __metrics 17:47:50 INFO - PROCESS | 1651 | 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" 17:47:50 INFO - PROCESS | 1651 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:47:51 INFO - TEST-INFO | 1651: exit 0 17:47:51 INFO - Browser initialized. 17:47:51 INFO - Running cycle 1/1 for kraken test... 17:47:51 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmpi_6vww/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:48:03 INFO - PROCESS | 1652 | RSS: Main: 237350912 17:48:03 INFO - PROCESS | 1652 | 17:48:06 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 17:48:07 INFO - PROCESS | 1652 | RSS: Main: 288894976 17:48:07 INFO - PROCESS | 1652 | 17:48:09 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 17:48:10 INFO - PROCESS | 1652 | RSS: Main: 290869248 17:48:10 INFO - PROCESS | 1652 | 17:48:13 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 17:48:14 INFO - PROCESS | 1652 | RSS: Main: 382803968 17:48:14 INFO - PROCESS | 1652 | 17:48:16 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 17:48:16 INFO - PROCESS | 1652 | RSS: Main: 284872704 17:48:16 INFO - PROCESS | 1652 | 17:48:18 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:48:19 INFO - PROCESS | 1652 | RSS: Main: 288149504 17:48:19 INFO - PROCESS | 1652 | 17:48:22 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 17:48:23 INFO - PROCESS | 1652 | RSS: Main: 330174464 17:48:23 INFO - PROCESS | 1652 | 17:48:25 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 17:48:26 INFO - PROCESS | 1652 | RSS: Main: 332038144 17:48:26 INFO - PROCESS | 1652 | 17:48:29 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 17:48:30 INFO - PROCESS | 1652 | RSS: Main: 330240000 17:48:30 INFO - PROCESS | 1652 | 17:48:31 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:48:32 INFO - PROCESS | 1652 | RSS: Main: 306180096 17:48:32 INFO - PROCESS | 1652 | 17:48:34 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:48:34 INFO - PROCESS | 1652 | RSS: Main: 312029184 17:48:34 INFO - PROCESS | 1652 | 17:48:37 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:48:37 INFO - PROCESS | 1652 | RSS: Main: 313020416 17:48:37 INFO - PROCESS | 1652 | 17:48:40 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:48:41 INFO - PROCESS | 1652 | RSS: Main: 329572352 17:48:41 INFO - PROCESS | 1652 | 17:48:44 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:48:45 INFO - PROCESS | 1652 | RSS: Main: 323842048 17:48:45 INFO - PROCESS | 1652 | 17:48:46 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 17:48:47 INFO - PROCESS | 1652 | RSS: Main: 368771072 17:48:47 INFO - PROCESS | 1652 | 17:48:47 INFO - PROCESS | 1652 | __start_tp_report 17:48:47 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 17:48:47 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 17:48:47 INFO - PROCESS | 1652 | |i|pagename|runs| 17:48:47 INFO - PROCESS | 1652 | |0;ai-astar;114;115;114;115;115;114;114;114;114;115 17:48:47 INFO - PROCESS | 1652 | |1;audio-beat-detection;145;116;111;150;114;113;111;112;131;113 17:48:47 INFO - PROCESS | 1652 | |2;audio-dft;183;187;184;187;179;180;189;186;183;184 17:48:47 INFO - PROCESS | 1652 | |3;audio-fft;83;60;59;88;64;61;59;59;76;62 17:48:47 INFO - PROCESS | 1652 | |4;audio-oscillator;86;69;85;68;70;69;85;67;67;84 17:48:47 INFO - PROCESS | 1652 | |5;imaging-gaussian-blur;88;87;88;88;88;87;87;87;88;88 17:48:47 INFO - PROCESS | 1652 | |6;imaging-darkroom;94;94;94;94;93;94;95;95;95;94 17:48:47 INFO - PROCESS | 1652 | |7;imaging-desaturate;87;86;89;99;118;86;85;86;87;85 17:48:47 INFO - PROCESS | 1652 | |8;json-parse-financial;61;59;60;60;60;60;59;59;60;60 17:48:47 INFO - PROCESS | 1652 | |9;json-stringify-tinderbox;65;75;73;76;72;69;69;68;69;69 17:48:47 INFO - PROCESS | 1652 | |10;stanford-crypto-aes;91;88;91;89;91;89;89;91;90;88 17:48:47 INFO - PROCESS | 1652 | |11;stanford-crypto-ccm;150;149;148;145;151;128;144;144;201;152 17:48:47 INFO - PROCESS | 1652 | |12;stanford-crypto-pbkdf2;174;176;176;176;175;174;178;173;171;172 17:48:47 INFO - PROCESS | 1652 | |13;stanford-crypto-sha256-iterative;68;69;68;67;67;67;71;77;83;83 17:48:47 INFO - PROCESS | 1652 | __end_tp_report 17:48:47 INFO - PROCESS | 1652 | __start_cc_report 17:48:47 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,2047 17:48:47 INFO - PROCESS | 1652 | __end_cc_report 17:48:47 INFO - PROCESS | 1652 | __startTimestamp1486604927139__endTimestamp 17:48:47 INFO - PROCESS | 1652 | 17:48:47 INFO - PROCESS | 1652 | ------- Summary: start ------- 17:48:47 INFO - PROCESS | 1652 | Number of tests: 14 17:48:47 INFO - PROCESS | 1652 | 17:48:47 INFO - PROCESS | 1652 | [#0] ai-astar Cycles:10 Average:114.40 Median:114.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 17:48:47 INFO - PROCESS | 1652 | Values: 114.0 115.0 114.0 115.0 115.0 114.0 114.0 114.0 114.0 115.0 17:48:47 INFO - PROCESS | 1652 | 17:48:47 INFO - PROCESS | 1652 | [#1] audio-beat-detection Cycles:10 Average:121.60 Median:115.00 stddev:14.89 (13.0%) stddev-sans-first:13.17 17:48:47 INFO - PROCESS | 1652 | Values: 145.0 116.0 111.0 150.0 114.0 113.0 111.0 112.0 131.0 113.0 17:48:47 INFO - PROCESS | 1652 | 17:48:47 INFO - PROCESS | 1652 | [#2] audio-dft Cycles:10 Average:184.20 Median:185.00 stddev:3.16 (1.7%) stddev-sans-first:3.32 17:48:47 INFO - PROCESS | 1652 | Values: 183.0 187.0 184.0 187.0 179.0 180.0 189.0 186.0 183.0 184.0 17:48:47 INFO - PROCESS | 1652 | 17:48:47 INFO - PROCESS | 1652 | [#3] audio-fft Cycles:10 Average:67.10 Median:63.00 stddev:11.00 (17.5%) stddev-sans-first:10.05 17:48:47 INFO - PROCESS | 1652 | Values: 83.0 60.0 59.0 88.0 64.0 61.0 59.0 59.0 76.0 62.0 17:48:47 INFO - PROCESS | 1652 | 17:48:47 INFO - PROCESS | 1652 | [#4] audio-oscillator Cycles:10 Average:75.00 Median:77.00 stddev:8.67 (11.3%) stddev-sans-first:8.23 17:48:47 INFO - PROCESS | 1652 | Values: 86.0 69.0 85.0 68.0 70.0 69.0 85.0 67.0 67.0 84.0 17:48:47 INFO - PROCESS | 1652 | 17:48:47 INFO - PROCESS | 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:87.60 Median:88.00 stddev:0.52 (0.6%) stddev-sans-first:0.53 17:48:47 INFO - PROCESS | 1652 | Values: 88.0 87.0 88.0 88.0 88.0 87.0 87.0 87.0 88.0 88.0 17:48:47 INFO - PROCESS | 1652 | 17:48:47 INFO - PROCESS | 1652 | [#6] imaging-darkroom Cycles:10 Average:94.20 Median:94.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 17:48:47 INFO - PROCESS | 1652 | Values: 94.0 94.0 94.0 94.0 93.0 94.0 95.0 95.0 95.0 94.0 17:48:47 INFO - PROCESS | 1652 | 17:48:47 INFO - PROCESS | 1652 | [#7] imaging-desaturate Cycles:10 Average:90.80 Median:86.50 stddev:10.41 (12.0%) stddev-sans-first:10.95 17:48:47 INFO - PROCESS | 1652 | Values: 87.0 86.0 89.0 99.0 118.0 86.0 85.0 86.0 87.0 85.0 17:48:47 INFO - PROCESS | 1652 | 17:48:47 INFO - PROCESS | 1652 | [#8] json-parse-financial Cycles:10 Average:59.80 Median:60.00 stddev:0.63 (1.1%) stddev-sans-first:0.50 17:48:47 INFO - PROCESS | 1652 | Values: 61.0 59.0 60.0 60.0 60.0 60.0 59.0 59.0 60.0 60.0 17:48:47 INFO - PROCESS | 1652 | 17:48:47 INFO - PROCESS | 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:70.50 Median:70.50 stddev:3.41 (4.8%) stddev-sans-first:2.98 17:48:47 INFO - PROCESS | 1652 | Values: 65.0 75.0 73.0 76.0 72.0 69.0 69.0 68.0 69.0 69.0 17:48:47 INFO - PROCESS | 1652 | 17:48:47 INFO - PROCESS | 1652 | [#10] stanford-crypto-aes Cycles:10 Average:89.70 Median:90.50 stddev:1.25 (1.4%) stddev-sans-first:1.24 17:48:47 INFO - PROCESS | 1652 | Values: 91.0 88.0 91.0 89.0 91.0 89.0 89.0 91.0 90.0 88.0 17:48:47 INFO - PROCESS | 1652 | 17:48:47 INFO - PROCESS | 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:151.20 Median:149.50 stddev:18.79 (12.6%) stddev-sans-first:19.92 17:48:47 INFO - PROCESS | 1652 | Values: 150.0 149.0 148.0 145.0 151.0 128.0 144.0 144.0 201.0 152.0 17:48:47 INFO - PROCESS | 1652 | 17:48:47 INFO - PROCESS | 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.50 Median:175.50 stddev:2.12 (1.2%) stddev-sans-first:2.24 17:48:47 INFO - PROCESS | 1652 | Values: 174.0 176.0 176.0 176.0 175.0 174.0 178.0 173.0 171.0 172.0 17:48:47 INFO - PROCESS | 1652 | 17:48:47 INFO - PROCESS | 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.00 Median:70.00 stddev:6.53 (9.3%) stddev-sans-first:6.77 17:48:47 INFO - PROCESS | 1652 | Values: 68.0 69.0 68.0 67.0 67.0 67.0 71.0 77.0 83.0 83.0 17:48:47 INFO - PROCESS | 1652 | -------- Summary: end -------- 17:48:47 INFO - PROCESS | 1652 | 17:48:48 INFO - TEST-INFO | 1652: exit 0 17:48:48 INFO - TEST-OK | kraken | took 60371ms 17:48:48 INFO - SUITE-END | took 1179s 17:48:48 INFO - Completed test suite (00:19:39) 17:48:48 INFO - javascript benchmark 17:48:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6992.260410737204, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3313.4201514734914, 3317.6184738755037, 3318.153870762955, 3342.364950659376, 3384.746144039196, 4539.841105561306, 5408.972955135228, 5549.361823390312, 5589.86025349366, 5619.522340601049, 5536.944630553693, 5540.833774986757, 5572.60991730578, 5586.24585680933, 5653.462921022507, 4970.70175789452, 5048.318477005603, 5052.166392545226, 5161.0968080585935, 5204.141316682742, 5161.17421212606, 5214.895702085956, 5227.18978558324, 5235.450277720842, 5260.710660913648, 4107.747137123176, 4970.453250142481, 4988.226824842155, 5119.462456442076, 5149.562287205592, 5016.046951079284, 5029.899402011939, 5040.042391945519, 5049.1416459201655, 5056.924146137811, 4446.955530444687, 5011.173156429221, 5018.021485810268, 5040.34475518184, 5094.974525127351, 5534.557235421156, 5555.8888822223735, 5557.694326812024, 5637.746301416446, 5652.06740887753, 6058.606190597641, 6117.816465506042, 6126.938730612681, 6131.816045518642, 6145.508359331243, 5932.288125424977, 5946.07835785454, 5996.760129594811, 6248.187735594389, 6261.092141639482, 5660.688662123582, 5703.0, 5709.257796486513, 5724.112762521816, 5739.339975902824, 6272.341404152589, 6307.9369206308265, 6320.241571011508, 6330.968345158337, 6346.365363463617, 5811.506021988093, 5857.853553661107, 5862.912056319158, 6009.819705408845, 6085.08723691441, 6174.722137503823, 6224.906626400608, 6225.470834979077, 6235.532335074888, 6239.656818875005, 6158.445739883432, 6164.506839452923, 6171.13604095427, 6171.59884607499, 6177.938220617736, 5745.712714364348, 5774.3070831499645, 6197.96901015492, 6199.442050215503, 6202.596831205957, 4820.566149046533, 4901.828436004794, 4945.7774400152075, 4961.578265847444, 4989.451160372429, 4415.536368681306, 4442.822287108479, 4445.51099379068, 4485.192665320208, 4520.2089634314525, 5544.944550554524, 5619.241402410704, 5625.212470254168, 5627.0, 5634.154876768517, 6027.7287522061615, 6089.69551522431, 6095.512359011268, 6146.385361463817, 6215.378462153749, 5583.190437386556, 5650.0, 5676.829695109153, 5713.05734553794, 5739.339975902742, 5425.810096646598, 5433.2936718227165, 5440.863978400572, 5441.7279136043835, 5460.672359658353, 6227.439530442282, 6229.781957631551, 6267.965785645318, 6271.843203919847, 6289.308176100534, 5967.9701601491715, 6001.009833377444, 6002.669853157943, 6110.5587591967305, 6274.498040156868, 6286.18279623646, 6293.622382657055, 6303.243610766737, 6305.243370795534, 6329.398707122816, 6012.218411606463, 6107.541934354852, 6112.541559383153, 6118.296395914527, 6125.540584456273, 5906.26171728534, 5971.223740913653, 6230.875382492234, 6237.875242495215, 6240.344763799736, 5714.171445140349, 5884.58807883444, 5918.260217472816, 5962.731677074456, 6006.609570377911, 5753.683547404766, 5800.274965629296, 5818.010938140611, 5852.239208902815, 5952.672603006876, 4874.658773885794, 5739.569532285179, 5761.39505351932, 5810.331811841692, 5841.532677385884, 5979.13302571116, 5983.461488466059, 5986.221791167294, 5986.431289027535, 5991.101334799815, 5537.640053396516, 5643.0, 5656.745446454837, 5700.800471983461, 5717.456841600041], "value": 5582.732288330426, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [458.639967625414, 471.40132032318934, 500.99300406183585, 521.3300908332791, 524.9553388756374, 23369.415764605892, 30573.847130764316, 37180.628193718054, 38798.030049248715, 38933.41599876004, 40308.79845600775, 40671.79664101675, 40749.38875916856, 40833.795831020805, 40870.795646021805, 7776.0, 8922.197002269795, 9120.361574689774, 9128.269738420944, 9141.680041198559, 7674.040744906887, 10629.787404251949, 10849.837252441219, 10856.294340867858, 10995.835062474029, 10797.136229101652, 10924.180686448548, 10945.398003109825, 11005.229633925628, 11007.669769906915, 7686.769396918102, 7936.484128531627, 10947.83578246327, 11020.50407731654, 11100.61147859821, 10595.417252051135, 10879.619213327496, 10905.563777448893, 10925.180611454094, 10959.178061645409, 38268.617313826784, 38580.0, 38615.84152475402, 38740.225195495936, 38750.80624596859, 3224.9032529024166, 3778.5087938568086, 3781.2248489059953, 3783.39465685489, 3816.2382082527283, 28532.572011419845, 28662.0, 29024.0, 29042.0, 29333.559996600066, 3046.2688954650944, 3074.815511069343, 3099.9535006974916, 3115.0873932872837, 3133.4203172413177, 300474.0, 300643.49034764495, 300956.0, 301510.0, 302867.9999999978, 51040.489595104315, 51283.487165128616, 59903.10145347823, 60901.69549152226, 61499.6925015381, 61477.38522614717, 62672.68663656653, 62943.0, 65093.349066509676, 65237.67381163064, 14577.052491588012, 14762.852371476149, 14782.556523304318, 14783.852161478248, 14838.480653177086, 11206.103511719206, 11219.439028048564, 11303.947934057758, 11331.43342832855, 11343.602973895873, 14529.927350363181, 15256.618584535254, 16527.421540246032, 16540.172991350384, 16586.75119873203, 6351.364863513611, 6376.872462550723, 6418.646974416359, 6441.677916104176, 6449.484041276686, 795.836853445054, 819.2749416766205, 821.5194111444872, 821.5809936932088, 840.315143158324, 27442.725572744417, 28579.857100714362, 28627.0, 28740.99406520762, 29622.703772962424, 946.2808265718104, 978.8629591857145, 1019.3527110285022, 1020.3265844542566, 1035.9274850760373, 14694.265286735621, 14771.704565908622, 14943.178125203001, 15155.0, 15237.238138093051, 431445.0, 487900.0, 492129.0, 492149.0, 492585.53707231954, 54896.725516372164, 55063.0, 55063.724681376334, 55074.724626376614, 55086.0, 1310.233513394675, 1345.18616237179, 1345.9932700336435, 1348.7976803479557, 1355.3426588104762, 27396.58905116385, 27699.72300277052, 28258.434831302846, 28679.85280588753, 29078.7092129076, 47781.0, 48010.51989480061, 48208.517914820404, 48321.7919552014, 48497.75751121222, 418931.0, 422456.0, 423514.0, 423653.0, 423697.0, 37159.44260836144, 37583.0, 37623.43564846584, 37646.0, 37738.43392349062, 42158.36762448627, 42318.78840605777, 42523.78738106413, 42787.0, 43643.78178109089, 35012.47481287732, 35130.47304290387, 35364.46953295754, 36012.4598131023, 36260.81869590635, 35018.0, 35032.82483587668, 36074.819625901706, 36286.09284767902, 36424.81787591045, 34529.30941381108, 34761.95714128479, 34962.47556286708, 35584.64415355813, 35589.46615800817, 29368.412631746818, 29645.70354296516, 30639.08082757521, 30855.845720771253, 30906.227344316572, 22098.33704988853, 22518.549629007, 23068.4232894179, 23156.536869262185, 23474.765252347257], "value": 18679.5682138702, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.34956902790486, 386.57669851512594, 387.08261420433575, 400.4753772557949, 414.5150174296073, 13742.587722368333, 14218.360173792178, 15099.849001509969, 19969.700454493195, 20100.396988090342, 20203.39389818304, 20408.69386959193, 21035.0, 21177.047032883518, 21249.468763280925, 5376.704281264529, 5493.560515158788, 5609.719514024282, 5689.3172819261745, 5703.74333155009, 5565.3599836018975, 5586.91619625706, 5643.322801263834, 5655.462731040545, 5658.943410565883, 3844.384898416254, 4056.8174432150477, 5631.1271752878365, 5939.227900372945, 6267.71795269214, 6024.0662697282, 6274.843128921791, 6323.20959880015, 6325.335839736807, 6329.651869147195, 5422.186671999192, 5489.39616642169, 5498.532624726903, 5502.614816962814, 5505.366882808488, 23066.53866922669, 25276.0, 25354.49291014188, 25450.618240726402, 25635.74364256352, 2469.876506174702, 2524.1417917907997, 2566.2557858221094, 2581.5998520229396, 2626.18588237645, 9891.604335826558, 9904.95047524765, 10348.723280878196, 13352.132111412728, 14088.225147616877, 1633.779439775627, 1662.3267576631483, 1805.3049575913237, 1806.3406856497415, 1816.7547381103514, 129806.0, 135305.32347338297, 135657.0, 138966.3051684735, 139840.99999999898, 11602.477888495037, 11662.88337116618, 11823.940880295715, 11913.52345906154, 12015.459304331325, 13542.526011589547, 15369.231538423033, 15375.308111135026, 15654.843451565339, 15748.370065197263, 7935.166807485246, 8229.711960081368, 8369.204925532065, 8394.390412122724, 8447.95776021116, 7964.84070318602, 7973.122956474783, 8115.513069215748, 8123.309518690978, 8140.104588495261, 4701.6003639690325, 4785.832495862698, 4796.8081276749235, 4798.95201047992, 4879.608991594093, 1746.9825301747073, 2011.8834047103705, 2012.8087831655969, 2048.9077991490417, 2050.251658144766, 944.6976967370513, 992.4343124419012, 1009.3035805294323, 1017.0947856407803, 1026.9422494830337, 20626.65926714759, 21185.0, 21215.469613259484, 21236.798511583456, 21584.568308633738, 986.2455221755363, 1009.6769033909079, 1031.9948400257952, 1044.0968562193648, 1059.2585190366774, 10749.462526873625, 10984.06635435981, 11114.444277786079, 11195.60815371458, 11244.718882027852, 622561.0, 697123.0, 709808.0, 718641.0, 726549.0, 140978.2951085238, 149256.0, 150571.0, 154486.0, 155365.0, 968.8934217236099, 1005.5173516711873, 1017.9236557258236, 1023.2581378500528, 1023.5087158163974, 18632.0, 19419.708704369164, 19486.025698714722, 19493.317733879812, 19527.902360488108, 57627.42372576221, 57643.71178144083, 57848.84302313846, 58114.709426452595, 58604.0, 76965.2303476958, 78991.60504197443, 81193.0, 83829.58085209534, 84518.0, 8165.836053445961, 8386.203310685476, 8460.196281353261, 8470.364722645703, 8664.696735614223, 12293.56972505958, 12918.806217906927, 13058.281794501014, 13447.932760336136, 13585.932070339584, 11156.051735602565, 11236.93249141363, 11458.94270528642, 11634.88365116338, 11729.41352932367, 11236.550537978716, 11390.37352945596, 11404.714882128013, 11503.02224310943, 11751.706207344543, 11297.604583839526, 11475.770484590428, 11530.711732206762, 11554.248973816675, 11841.23032002917, 7293.708251669874, 8209.876851847346, 8397.110650103677, 8413.158684131538, 8511.95744021276, 8221.298867336362, 11114.944425277821, 11197.44012799373, 11281.492332844877, 11442.970132688099], "value": 9803.256230100018, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1251.4931452761632, 1305.9682850548065, 1386.5285802827036, 1441.0849110814643, 1452.1359790924403, 7745.2641999010075, 8111.91888081119, 8117.797055073626, 8121.959390203048, 8134.959325203366, 7884.881726774089, 8155.714549990752, 8208.83582328353, 8341.833163336729, 8345.83308333833, 2042.5506388594486, 2124.617568837609, 2236.373815331706, 2273.8067264282554, 2278.9658155127686, 1949.5516031312807, 2226.7773222677765, 2273.9772602274015, 2274.920377786778, 2276.226083131735, 1987.1554589299562, 2008.789077146893, 2008.8694234874758, 2010.4270282969358, 2010.5174758058033, 2181.901814418347, 2254.8196144308417, 2259.9096036158535, 2260.8078313343385, 2263.117384220164, 1810.6650269700017, 2247.955040899189, 2251.1990407673798, 2258.9947473374355, 2260.6156953317977, 8220.013598368234, 8270.503769773773, 8275.668973241063, 8297.460665056751, 8310.501369917823, 5009.824656137054, 5176.0, 5188.844334669928, 5193.0, 5202.635815492879, 2883.5674648802637, 3232.337370838996, 3395.2530443302435, 3399.983000084984, 3476.184290724496, 1033.3541536539663, 1046.6441409920662, 1132.6729263427746, 1165.81929800881, 1195.5337418406828, 10731.570737170503, 10774.892251077466, 10804.459777011196, 10858.402787846666, 10869.83695244572, 3584.2473080652835, 3704.9073773155887, 4046.4941882264716, 4243.575642435793, 4463.107378524308, 7223.241559636268, 8395.328373730086, 8414.663413463393, 8553.871691924625, 8592.312614990911, 4279.87160385189, 4908.239222920453, 4912.828051018198, 4914.705117692878, 4940.90118197634, 3903.7703123516003, 4448.266036104072, 4549.909001819945, 4755.595774359149, 4758.5241475852135, 3537.3102245061964, 3546.3261980223674, 3564.7326450516316, 3606.8376923038527, 3621.311950729353, 1121.9046381057537, 1123.971900702489, 1126.5606413498742, 1136.8863113688565, 1145.541783286692, 742.907136607924, 753.3144838197214, 771.097815555801, 779.7076096463826, 799.4471484893592, 5321.760520776575, 5416.404195538487, 5449.373322067933, 5461.0716178249795, 5555.194496798023, 549.6564647095565, 554.5064892245904, 578.5458415144092, 585.2508788750406, 587.2189987316943, 3591.712662986955, 3626.437902125175, 3679.392900171442, 3740.925181496355, 3757.3236817373136, 9468.952655236817, 9877.308588398886, 9884.851727224097, 9885.802283954281, 9886.258530610234, 9744.853827192597, 9905.009499050182, 9906.306558540833, 9908.256880733974, 9932.900670993198, 7258.455615828834, 7559.055118110236, 7635.007449031701, 7648.770536883902, 7675.0, 5327.254184414262, 5590.189422533791, 5677.403872593318, 5710.5146062585145, 5724.627899186539, 8721.302295816446, 8916.242119419921, 9000.099990000948, 9104.089591040844, 9216.216621586971, 9198.95400522993, 9241.306901982243, 9289.024652411399, 9362.344635875696, 9378.765530861783, 6928.653567321513, 7140.178879428932, 7146.535475194096, 7150.249223831631, 7161.4628902831455, 7685.884711729217, 7692.269234422721, 7704.152543220353, 7707.11368192665, 7784.688612455665, 5672.546196304368, 6980.476464265099, 7054.894176587458, 7093.255208203064, 7155.785326440215, 6770.187577490733, 6949.930500695131, 7015.508914375945, 7065.682044307916, 7071.611061391673, 6179.0, 6253.062040693932, 6379.362063793584, 6381.936180638134, 6394.200724909387, 4581.541845815392, 4840.322354870392, 4914.778834952364, 4947.554720075211, 4948.505149485023, 4787.54518320759, 4871.756412179306, 4922.704637721748, 4999.675021123615, 5158.329417175743], "value": 4186.332953143567, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.2212802457561, 309.33338655198025, 345.74315676873414, 361.85525789684124, 362.57397557869496, 4470.955290447095, 4572.8399506017295, 5291.629585928987, 5300.549453296474, 5331.546818520425, 4421.960839202793, 4927.663655982739, 5074.517920797528, 5109.237313126974, 5186.662866913657, 3626.4379021251684, 3654.872079477219, 3734.9813250933844, 3938.547067087293, 3963.1875465529497, 3795.259924314746, 3958.307296223164, 3966.643002129808, 3971.0, 3997.380406037069, 3598.4242521196484, 3700.5946135012186, 3933.193695292458, 3950.723449358546, 3958.366661334187, 3728.5898551159353, 3924.1759230561615, 3940.0, 3947.5262968443826, 3959.089409435846, 2894.8552572371295, 3425.417678994552, 3448.8100056464077, 3451.6548345165534, 3466.722662187019, 4252.851150209759, 4468.620167285784, 4671.299305104228, 5132.332796736438, 5142.305788718512, 3215.5015972524297, 4187.801404262756, 4327.805248763813, 4443.644508439317, 4542.545745425464, 4623.0, 4945.307656928033, 5132.948670513321, 5508.531774799147, 5537.587915081669, 3761.605031471711, 3762.5861155272896, 3778.3387907116144, 3782.3569993101237, 3789.7347185697013, 4848.9757551212015, 4885.36490256268, 5279.0, 5320.430473010471, 5708.003298268401, 3463.87876424329, 3708.6053027162898, 3774.6791522720328, 3784.526934133233, 3788.1476667749534, 3840.30874442603, 3843.0968722350226, 3857.324968130566, 3862.304785138702, 3876.2828876657345, 3787.5265591801026, 4147.751134931914, 4463.0, 4528.637708983273, 4534.682572219913, 4456.373423700326, 4722.409698787652, 5247.63266571344, 5250.579953603703, 5593.496585307261, 1052.4685034057752, 1262.1228246368685, 1281.5774490315741, 1286.4498279573093, 1301.8828305452555, 747.2998927440009, 855.9443636163629, 857.8155696525278, 858.7552547523926, 866.0559989611354, 4893.106893106893, 4896.804127834918, 4948.356713627278, 4948.851534453972, 4969.652124351261, 4717.599004084623, 4905.632077594195, 5105.0, 5282.841514754564, 5450.3732070811575, 4551.8350709100805, 4897.608191344684, 4925.38432695913, 4928.732782919826, 4935.90128197434, 2427.3446169534127, 2822.647169103862, 2871.7128287171536, 2897.4060317634835, 2935.691752365971, 5126.820561280412, 5361.812336568201, 5380.3274590676165, 5671.8865622688145, 5677.943220567741, 4291.866937135846, 5041.529650471242, 5070.526689217824, 5469.3983661797965, 5568.916466253009, 5405.270338479043, 5422.755975981011, 5529.147735508569, 5628.690422026828, 5648.898464799325, 4842.7336496493035, 5417.42894560573, 5430.402655707948, 5453.972730136324, 5475.616706830484, 4695.882602934954, 4872.342233798392, 4973.950260497493, 5275.657082289639, 5334.839954801362, 4791.520847915181, 4936.851894443173, 5585.273914391103, 5606.215129881902, 5615.943840561542, 2987.0, 3388.5425467561563, 3606.9098272542346, 3626.0753507856384, 3629.455581662666, 4338.544452832533, 4608.110674623388, 4981.850544483671, 5396.384422437055, 5432.348118225838, 4206.663466922578, 4509.616682582017, 4727.645426592951, 4968.0, 5187.325647665779, 4428.402165707588, 4818.95181048185, 5065.189569668983, 5239.175401956517, 5242.921356179584, 4158.812853421543, 4238.3430568261965, 4270.572942705705, 4714.457837348748, 5135.897282054413, 4714.717116972993, 4917.877053073702, 5225.451327610698, 5228.37259528859, 5298.576113910801, 4432.29083346663, 5132.307138536399, 5146.202338637517, 5164.690118592896, 5180.989707007248], "value": 3861.615674738506, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [702.5117543307397, 718.8095154783983, 751.8383547537281, 767.7773445700747, 794.4200733464569, 14203.715925681494, 14895.92552037241, 14916.62708432287, 14949.925250373746, 14954.700905981874, 11980.940095299533, 13066.542671006517, 13139.605811825637, 13281.0, 13390.799138012913, 858.9398742088056, 864.5590748718137, 864.6325311742515, 870.3776799588293, 873.1792115411524, 865.1953683074738, 865.4590880699562, 866.3285953386113, 866.33292364879, 866.7053201911349, 806.379088102161, 859.6561375449808, 859.6604341285189, 909.8771665825128, 910.4446287764458, 901.0403919825364, 901.2249465459699, 902.3007169443669, 904.1184844776291, 904.3082042237694, 659.993400065998, 662.2384258103219, 662.8541720821412, 664.2659860853736, 665.8235567574596, 12316.692082698004, 12595.748085038247, 12706.174098683648, 12751.489940402373, 12795.424205910756, 11475.254108482923, 11516.96347328736, 11594.188406811527, 11709.355985420798, 11992.460339284753, 8391.958040209822, 10112.0, 10209.846852297222, 10212.438315892623, 10592.099671527929, 3413.2832105257926, 3482.199094208346, 3485.2158264390564, 3508.0, 3512.7189824813954, 96265.0, 96485.0, 96495.0, 101247.0, 102750.0, 8477.279431248413, 8494.277986371228, 8575.95712021436, 8614.87077693835, 8716.311456221658, 18532.722009169873, 18768.436946891616, 18773.1552080154, 18805.059747012594, 18853.0, 6475.643839588868, 7227.385672217921, 7382.22486638906, 7510.849783004419, 7625.389968802482, 3909.3745000799736, 4101.26177288091, 4121.505419349697, 4165.875023749292, 4175.331946888544, 3372.544706464596, 3429.34842379952, 3450.7584469086923, 3450.9482357764655, 3469.028671971852, 639.245690085694, 643.32129603269, 645.2643985856128, 657.0932113683182, 658.868226354731, 618.703022549179, 634.2357459261578, 639.3798015924546, 648.9513286503532, 657.6054367379629, 7285.526440781332, 7922.960385198037, 9190.770230744285, 9657.501398769038, 10829.350238985686, 555.2143716640908, 585.6954383720526, 592.6710675575011, 636.3413866647998, 712.1383126417094, 4515.887102822456, 4819.855404337875, 4838.346823178897, 4841.464320190053, 4925.21196608541, 82461.58769206236, 83440.0, 86409.70385444224, 89342.0, 90102.0, 70833.64583177051, 74729.0, 77453.45093098219, 77909.83135252976, 78497.0, 65853.67073164604, 67520.66239668771, 69078.65460672765, 73658.0, 75867.62066189633, 10343.338050197422, 10675.733106672085, 10744.140468762636, 10961.12311015101, 10976.780464390507, 45793.77103114597, 46658.53341466542, 48402.273965889835, 50509.74745126398, 53314.4668553325, 61703.38296616976, 65107.69784604376, 65516.672416637615, 65702.0, 65852.670736646, 11009.889901100887, 12452.68868278264, 12856.871431285941, 12858.164219325714, 12952.0, 14237.637600923965, 14291.64270893236, 14670.706585868436, 14814.185219813015, 15386.538403847902, 13047.646009963206, 13265.80101298462, 13391.933040334736, 13708.862911371158, 13849.930750346184, 10640.787184256425, 13327.466901323838, 13395.598132056053, 13398.531051413154, 13623.912826152313, 12632.557860474839, 12768.297743624189, 13223.404946777611, 13615.25116118623, 13651.590452286448, 10885.782284354427, 11032.944835275772, 11280.887191127984, 11448.255863368855, 11506.597269095542, 8252.669893204205, 10457.315104955422, 10700.625478108228, 10721.24951253436, 10795.29830561011], "value": 7070.798649396994, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1452.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 115.0, 115.0, 114.0, 114.0, 114.0, 114.0, 115.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 116.0, 111.0, 150.0, 114.0, 113.0, 111.0, 112.0, 131.0, 113.0], "value": 121.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 187.0, 184.0, 187.0, 179.0, 180.0, 189.0, 186.0, 183.0, 184.0], "value": 184.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 60.0, 59.0, 88.0, 64.0, 61.0, 59.0, 59.0, 76.0, 62.0], "value": 67.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 69.0, 85.0, 68.0, 70.0, 69.0, 85.0, 67.0, 67.0, 84.0], "value": 75.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 88.0, 88.0, 88.0, 87.0, 87.0, 87.0, 88.0, 88.0], "value": 87.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 93.0, 94.0, 95.0, 95.0, 95.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 89.0, 99.0, 118.0, 86.0, 85.0, 86.0, 87.0, 85.0], "value": 90.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 59.0, 60.0, 60.0, 60.0, 60.0, 59.0, 59.0, 60.0, 60.0], "value": 59.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 75.0, 73.0, 76.0, 72.0, 69.0, 69.0, 68.0, 69.0, 69.0], "value": 70.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 88.0, 91.0, 89.0, 91.0, 89.0, 89.0, 91.0, 90.0, 88.0], "value": 89.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 148.0, 145.0, 151.0, 128.0, 144.0, 144.0, 201.0, 152.0], "value": 151.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 176.0, 176.0, 176.0, 175.0, 174.0, 178.0, 173.0, 171.0, 172.0], "value": 174.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 68.0, 67.0, 67.0, 67.0, 71.0, 77.0, 83.0, 83.0], "value": 72.0, "unit": "score"}]}]} 17:48:48 INFO - Return code: 0 17:48:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:48:48 ERROR - # TBPL SUCCESS # 17:48:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:48:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:48:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:48:48 INFO - 2017-02-08 17:48:48.435 screenresolution[1656:9656] starting screenresolution argv=screenresolution get 17:48:48 INFO - 2017-02-08 17:48:48.437 screenresolution[1656:9656] Display 0: 1600x1200x32@60 17:48:48 INFO - 2017-02-08 17:48:48.443 screenresolution[1657:9659] starting screenresolution argv=screenresolution list 17:48:48 INFO - Available Modes on Display 0 17:48:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:48:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:48:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:48:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:48:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:48:48 INFO - Intel Iris: 17:48:48 INFO - Chipset Model: Intel Iris 17:48:48 INFO - Type: GPU 17:48:48 INFO - Bus: Built-In 17:48:48 INFO - VRAM (Dynamic, Max): 1536 MB 17:48:48 INFO - Vendor: Intel (0x8086) 17:48:48 INFO - Device ID: 0x0a2e 17:48:48 INFO - Revision ID: 0x0009 17:48:48 INFO - Displays: 17:48:48 INFO - Display: 17:48:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:48:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:48:48 INFO - Display Serial Number: 1600x1200 60 17:48:48 INFO - Main Display: Yes 17:48:48 INFO - Mirror: Off 17:48:48 INFO - Online: Yes 17:48:48 INFO - Rotation: Supported 17:48:48 INFO - Return code: 0 17:48:48 INFO - Running post-action listener: _resource_record_post_action 17:48:48 INFO - [mozharness: 2017-02-09 01:48:48.680355Z] Finished run-tests step (success) 17:48:48 INFO - Running post-run listener: _resource_record_post_run 17:48:48 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 38974464; Write bytes: 553595392; Read time: 403; Write time: 1726 17:48:48 INFO - TinderboxPrint: CPU usage
53.8% 17:48:48 INFO - TinderboxPrint: I/O read bytes / time
38,974,464 / 403 17:48:48 INFO - TinderboxPrint: I/O write bytes / time
553,595,392 / 1,726 17:48:48 INFO - TinderboxPrint: CPU idle
2,221.9 (46.2%) 17:48:48 INFO - TinderboxPrint: CPU system
961.4 (20.0%) 17:48:48 INFO - TinderboxPrint: CPU user
1,626.4 (33.8%) 17:48:48 INFO - TinderboxPrint: Swap in / out
290,852,864 / 0 17:48:48 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 246565376; Write bytes: 238866432; Read time: 17793; Write time: 414 17:48:48 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 36938752; Write bytes: 299348480; Read time: 355; Write time: 1182 17:48:49 INFO - Running post-run listener: _upload_blobber_files 17:48:49 INFO - Blob upload gear active. 17:48:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:48:49 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:48:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:48:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:48:49 INFO - (blobuploader) - INFO - Open directory for files ... 17:48:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:48:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:48:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:48:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:48:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:48:50 INFO - (blobuploader) - INFO - Done attempting. 17:48:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:48:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:48:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:48:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:48:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:48:51 INFO - (blobuploader) - INFO - Done attempting. 17:48:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:48:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:48:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:48:52 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:48:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:48:52 INFO - (blobuploader) - INFO - Done attempting. 17:48:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:48:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:48:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:48:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:48:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:48:55 INFO - (blobuploader) - INFO - Done attempting. 17:48:55 INFO - (blobuploader) - INFO - Iteration through files over. 17:48:55 INFO - Return code: 0 17:48:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:48:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:48:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a58fa7dbccbe972d489fb15305d9850365f4dacc430ccbea29132d4ea099a469a90d4af83f91f1f1b6329058907e5d87ef9d24db0e1e5f973864c375b64737b9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f8fa446c336b9fea1158b11986b114d292a0f464524e69e96663a54ffa2686f9547a0b6d2b704a99ebfa661966bbc7abc26a6ba3210ff850350ac3d91265fed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d815dfa27fbf2d8a1d7b5720425dbd554160c455d35db1301f2b3e54fc134540ab69ce9e4dca8c4c50c6e8f4b12e2bd92fc554c4d9382099d167d25ecc33eb30", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad73be295a6045f20305f975bb0e86087cf877908c6006aa40a20b6b75ccd0a18f4e3ac8b4127756afd670378b66286c779a9c4cba9ddb99f69eb47d0492f3cc"} 17:48:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:48:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:48:55 INFO - Contents: 17:48:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a58fa7dbccbe972d489fb15305d9850365f4dacc430ccbea29132d4ea099a469a90d4af83f91f1f1b6329058907e5d87ef9d24db0e1e5f973864c375b64737b9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f8fa446c336b9fea1158b11986b114d292a0f464524e69e96663a54ffa2686f9547a0b6d2b704a99ebfa661966bbc7abc26a6ba3210ff850350ac3d91265fed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d815dfa27fbf2d8a1d7b5720425dbd554160c455d35db1301f2b3e54fc134540ab69ce9e4dca8c4c50c6e8f4b12e2bd92fc554c4d9382099d167d25ecc33eb30", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad73be295a6045f20305f975bb0e86087cf877908c6006aa40a20b6b75ccd0a18f4e3ac8b4127756afd670378b66286c779a9c4cba9ddb99f69eb47d0492f3cc"} 17:48:55 INFO - Running post-run listener: copy_logs_to_upload_dir 17:48:55 INFO - Copying logs to upload dir... 17:48:55 INFO - mkdir: /builds/slave/test/build/upload/logs 17:48:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.276649 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-02-08 17:48:55.258731) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-08 17:48:55.262218) ========= 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.IPiMkb0NBd/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.diNOcRojjn/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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/a58fa7dbccbe972d489fb15305d9850365f4dacc430ccbea29132d4ea099a469a90d4af83f91f1f1b6329058907e5d87ef9d24db0e1e5f973864c375b64737b9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f8fa446c336b9fea1158b11986b114d292a0f464524e69e96663a54ffa2686f9547a0b6d2b704a99ebfa661966bbc7abc26a6ba3210ff850350ac3d91265fed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d815dfa27fbf2d8a1d7b5720425dbd554160c455d35db1301f2b3e54fc134540ab69ce9e4dca8c4c50c6e8f4b12e2bd92fc554c4d9382099d167d25ecc33eb30", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad73be295a6045f20305f975bb0e86087cf877908c6006aa40a20b6b75ccd0a18f4e3ac8b4127756afd670378b66286c779a9c4cba9ddb99f69eb47d0492f3cc"} build_url:https://queue.taskcluster.net/v1/task/A86S5OApR0GkSKaMweJNtQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011058 build_url: 'https://queue.taskcluster.net/v1/task/A86S5OApR0GkSKaMweJNtQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a58fa7dbccbe972d489fb15305d9850365f4dacc430ccbea29132d4ea099a469a90d4af83f91f1f1b6329058907e5d87ef9d24db0e1e5f973864c375b64737b9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f8fa446c336b9fea1158b11986b114d292a0f464524e69e96663a54ffa2686f9547a0b6d2b704a99ebfa661966bbc7abc26a6ba3210ff850350ac3d91265fed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d815dfa27fbf2d8a1d7b5720425dbd554160c455d35db1301f2b3e54fc134540ab69ce9e4dca8c4c50c6e8f4b12e2bd92fc554c4d9382099d167d25ecc33eb30", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad73be295a6045f20305f975bb0e86087cf877908c6006aa40a20b6b75ccd0a18f4e3ac8b4127756afd670378b66286c779a9c4cba9ddb99f69eb47d0492f3cc"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-08 17:48:55.301061) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 17:48:55.301649) ========= 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.IPiMkb0NBd/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.diNOcRojjn/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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.005225 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 17:48:55.350967) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-08 17:48:55.351319) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-08 17:48:55.351734) ========= ========= Total master_lag: 0.19 =========