builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0019 starttime: 1461024817.1 results: success (0) buildid: 20160418150833 builduid: 3f60c97e7ef9444b87bd2ba9dfe1377a revision: fc2da6172138c3f1eeaea6a29a3f23be6c2cca7c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 17:13:37.097297) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 17:13:37.097717) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 10 secs) (at 2016-04-18 17:13:37.098043) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 10 secs) (at 2016-04-18 17:13:47.300323) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-04-18 17:13:47.300623) ========= 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.Wt0kMS9d70/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.uRIc258BA9/Listeners TMPDIR=/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-18 17:13:48-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 13.5M=0.001s 2016-04-18 17:13:49 (13.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.548108 ========= master_lag: 3.23 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-04-18 17:13:51.073964) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 17:13:51.074249) ========= 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.Wt0kMS9d70/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.uRIc258BA9/Listeners TMPDIR=/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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.027789 ========= master_lag: 0.76 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 17:13:51.857689) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-18 17:13:51.858007) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev fc2da6172138c3f1eeaea6a29a3f23be6c2cca7c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev fc2da6172138c3f1eeaea6a29a3f23be6c2cca7c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Wt0kMS9d70/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.uRIc258BA9/Listeners TMPDIR=/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-18 17:13:52,146 truncating revision to first 12 chars 2016-04-18 17:13:52,146 Setting DEBUG logging. 2016-04-18 17:13:52,146 attempt 1/10 2016-04-18 17:13:52,146 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/fc2da6172138?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-18 17:13:52,764 unpacking tar archive at: fx-team-fc2da6172138/testing/mozharness/ program finished with exit code 0 elapsedTime=0.855728 ========= master_lag: 0.42 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-18 17:13:53.129005) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 17:13:53.129281) ========= script_repo_revision: fc2da6172138c3f1eeaea6a29a3f23be6c2cca7c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 17:13:53.129655) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 17:13:53.129934) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 17:13:53.590646) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-04-18 17:13:53.591011) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Wt0kMS9d70/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.uRIc258BA9/Listeners TMPDIR=/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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:13:53 INFO - MultiFileLogger online at 20160418 17:13:53 in /builds/slave/test 17:13:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:13:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:13:53 INFO - {'append_to_log': False, 17:13:53 INFO - 'base_work_dir': '/builds/slave/test', 17:13:53 INFO - 'blob_upload_branch': 'Fx-Team', 17:13:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:13:53 INFO - 'branch': 'Fx-Team', 17:13:53 INFO - 'buildbot_json_path': 'buildprops.json', 17:13:53 INFO - 'config_files': ('talos/mac_config.py',), 17:13:53 INFO - 'default_actions': ('clobber', 17:13:53 INFO - 'read-buildbot-config', 17:13:54 INFO - 'download-and-extract', 17:13:54 INFO - 'populate-webroot', 17:13:54 INFO - 'create-virtualenv', 17:13:54 INFO - 'install', 17:13:54 INFO - 'run-tests'), 17:13:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:13:54 INFO - 'download_minidump_stackwalk': True, 17:13:54 INFO - 'download_symbols': 'ondemand', 17:13:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:13:54 INFO - 'tooltool.py': '/tools/tooltool.py', 17:13:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:13:54 INFO - '/tools/misc-python/virtualenv.py')}, 17:13:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:13:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:13:54 INFO - 'installer_path': 'installer.exe', 17:13:54 INFO - 'log_level': 'info', 17:13:54 INFO - 'log_name': 'talos', 17:13:54 INFO - 'log_to_console': True, 17:13:54 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:13:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:13:54 INFO - 'opt_config_files': (), 17:13:54 INFO - 'pip_index': False, 17:13:54 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:13:54 INFO - 'cmd': ('bash', 17:13:54 INFO - '-c', 17:13:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:13:54 INFO - 'enabled': True, 17:13:54 INFO - 'halt_on_failure': False, 17:13:54 INFO - 'name': 'check_screen_resolution'},), 17:13:54 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:13:54 INFO - 'cmd': ('bash', 17:13:54 INFO - '-c', 17:13:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:13:54 INFO - 'enabled': True, 17:13:54 INFO - 'halt_on_failure': False, 17:13:54 INFO - 'name': 'check_screen_resolution'},), 17:13:54 INFO - 'run_cmd_checks_enabled': True, 17:13:54 INFO - 'sps_profile': False, 17:13:54 INFO - 'sps_profile_interval': 0, 17:13:54 INFO - 'suite': 'dromaeojs', 17:13:54 INFO - 'system_bits': '32', 17:13:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:13:54 INFO - 'title': 't-yosemite-r7-0019', 17:13:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:13:54 INFO - 'use_talos_json': True, 17:13:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:13:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:13:54 INFO - 'work_dir': 'build'} 17:13:54 INFO - ##### 17:13:54 INFO - ##### Running clobber step. 17:13:54 INFO - ##### 17:13:54 INFO - Running pre-action listener: _resource_record_pre_action 17:13:54 INFO - Running main action method: clobber 17:13:54 INFO - rmtree: /builds/slave/test/build 17:13:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:13:55 INFO - Running post-action listener: _resource_record_post_action 17:13:55 INFO - ##### 17:13:55 INFO - ##### Running read-buildbot-config step. 17:13:55 INFO - ##### 17:13:55 INFO - Running pre-action listener: _resource_record_pre_action 17:13:55 INFO - Running main action method: read_buildbot_config 17:13:55 INFO - Using buildbot properties: 17:13:55 INFO - { 17:13:55 INFO - "project": "", 17:13:55 INFO - "product": "firefox", 17:13:55 INFO - "script_repo_revision": "production", 17:13:55 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 17:13:55 INFO - "repository": "", 17:13:55 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 17:13:55 INFO - "buildid": "20160418150833", 17:13:55 INFO - "pgo_build": "False", 17:13:55 INFO - "basedir": "/builds/slave/test", 17:13:55 INFO - "buildnumber": 734, 17:13:55 INFO - "slavename": "t-yosemite-r7-0019", 17:13:55 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 17:13:55 INFO - "platform": "yosemite_r7", 17:13:55 INFO - "scheduler": "tests-fx-team-macosx64-talos", 17:13:55 INFO - "branch": "fx-team", 17:13:55 INFO - "repo_path": "integration/fx-team", 17:13:55 INFO - "revision": "fc2da6172138c3f1eeaea6a29a3f23be6c2cca7c", 17:13:55 INFO - "stage_platform": "macosx64", 17:13:55 INFO - "builduid": "3f60c97e7ef9444b87bd2ba9dfe1377a", 17:13:55 INFO - "slavebuilddir": "test" 17:13:55 INFO - } 17:13:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/X5Myv5iTSrioPNtTH8zUxQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 17:13:55 INFO - Running post-action listener: _resource_record_post_action 17:13:55 INFO - ##### 17:13:55 INFO - ##### Running download-and-extract step. 17:13:55 INFO - ##### 17:13:55 INFO - Running pre-action listener: _resource_record_pre_action 17:13:55 INFO - Running main action method: download_and_extract 17:13:55 INFO - mkdir: /builds/slave/test/build/tests 17:13:55 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:55 INFO - https://queue.taskcluster.net/v1/task/X5Myv5iTSrioPNtTH8zUxQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 17:13:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5Myv5iTSrioPNtTH8zUxQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 17:13:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5Myv5iTSrioPNtTH8zUxQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 17:13:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5Myv5iTSrioPNtTH8zUxQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 17:13:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5Myv5iTSrioPNtTH8zUxQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 17:14:02 INFO - Downloaded 1199 bytes. 17:14:02 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 17:14:02 INFO - Using the following test package requirements: 17:14:02 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 17:14:02 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:14:02 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 17:14:02 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:14:02 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 17:14:02 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:14:02 INFO - u'jsshell-mac.zip'], 17:14:02 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:14:02 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 17:14:02 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 17:14:02 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:14:02 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 17:14:02 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:14:02 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 17:14:02 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:14:02 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 17:14:02 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:14:02 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 17:14:02 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:14:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:14:02 INFO - https://queue.taskcluster.net/v1/task/X5Myv5iTSrioPNtTH8zUxQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:14:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5Myv5iTSrioPNtTH8zUxQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:14:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5Myv5iTSrioPNtTH8zUxQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:14:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5Myv5iTSrioPNtTH8zUxQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:14:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5Myv5iTSrioPNtTH8zUxQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:14:03 INFO - Downloaded 18032111 bytes. 17:14:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:14:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 17:14:06 INFO - Return code: 0 17:14:06 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 17:14:06 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:14:06 INFO - https://queue.taskcluster.net/v1/task/X5Myv5iTSrioPNtTH8zUxQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:14:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5Myv5iTSrioPNtTH8zUxQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:14:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5Myv5iTSrioPNtTH8zUxQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:14:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5Myv5iTSrioPNtTH8zUxQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:14:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5Myv5iTSrioPNtTH8zUxQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:14:08 INFO - Downloaded 18032111 bytes. 17:14:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:14:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 17:14:12 INFO - Return code: 0 17:14:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:14:12 INFO - https://queue.taskcluster.net/v1/task/X5Myv5iTSrioPNtTH8zUxQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 17:14:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5Myv5iTSrioPNtTH8zUxQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 17:14:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5Myv5iTSrioPNtTH8zUxQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 17:14:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5Myv5iTSrioPNtTH8zUxQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 17:14:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5Myv5iTSrioPNtTH8zUxQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 17:14:13 INFO - Downloaded 10845952 bytes. 17:14:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:14:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 17:14:13 INFO - Return code: 0 17:14:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:14:13 INFO - https://queue.taskcluster.net/v1/task/X5Myv5iTSrioPNtTH8zUxQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 17:14:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5Myv5iTSrioPNtTH8zUxQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 17:14:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5Myv5iTSrioPNtTH8zUxQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 17:14:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5Myv5iTSrioPNtTH8zUxQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 17:14:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5Myv5iTSrioPNtTH8zUxQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 17:14:17 INFO - Downloaded 109966043 bytes. 17:14:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/X5Myv5iTSrioPNtTH8zUxQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 17:14:17 INFO - mkdir: /builds/slave/test/properties 17:14:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:14:17 INFO - Writing to file /builds/slave/test/properties/build_url 17:14:17 INFO - Contents: 17:14:17 INFO - build_url:https://queue.taskcluster.net/v1/task/X5Myv5iTSrioPNtTH8zUxQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 17:14:18 INFO - Running post-action listener: _resource_record_post_action 17:14:18 INFO - Running post-action listener: set_extra_try_arguments 17:14:18 INFO - ##### 17:14:18 INFO - ##### Running populate-webroot step. 17:14:18 INFO - ##### 17:14:18 INFO - Running pre-action listener: _resource_record_pre_action 17:14:18 INFO - Running main action method: populate_webroot 17:14:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:14:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:14:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:14:18 INFO - '--tppagecycles', 17:14:18 INFO - '7'], 17:14:18 INFO - 'tests': ['tsvgm']}}, 17:14:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:14:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:14:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:14:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:14:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:14:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:14:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:14:18 INFO - 'talos_options': ['--disable-e10s'], 17:14:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:14:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:14:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:14:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:14:18 INFO - 'talos_options': ['--disable-e10s'], 17:14:18 INFO - 'tests': ['damp', 'tps']}, 17:14:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:14:18 INFO - 'tests': ['damp', 'tps']}, 17:14:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:14:18 INFO - 'tests': ['dromaeo_dom']}, 17:14:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:14:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:14:18 INFO - 'tests': ['a11yr', 17:14:18 INFO - 'ts_paint', 17:14:18 INFO - 'tpaint', 17:14:18 INFO - 'sessionrestore', 17:14:18 INFO - 'sessionrestore_no_auto_restore', 17:14:18 INFO - 'tabpaint']}, 17:14:18 INFO - 'other-e10s': {'tests': ['a11yr', 17:14:18 INFO - 'ts_paint', 17:14:18 INFO - 'tpaint', 17:14:18 INFO - 'sessionrestore', 17:14:18 INFO - 'sessionrestore_no_auto_restore', 17:14:18 INFO - 'tabpaint']}, 17:14:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:14:18 INFO - 'ts_paint', 17:14:18 INFO - 'tpaint', 17:14:18 INFO - 'sessionrestore', 17:14:18 INFO - 'sessionrestore_no_auto_restore', 17:14:18 INFO - 'tabpaint']}, 17:14:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:14:18 INFO - 'ts_paint', 17:14:18 INFO - 'tpaint', 17:14:18 INFO - 'sessionrestore', 17:14:18 INFO - 'sessionrestore_no_auto_restore', 17:14:18 INFO - 'tabpaint']}, 17:14:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:14:18 INFO - 'tests': ['a11yr', 17:14:18 INFO - 'ts_paint', 17:14:18 INFO - 'tpaint', 17:14:18 INFO - 'sessionrestore', 17:14:18 INFO - 'sessionrestore_no_auto_restore', 17:14:18 INFO - 'tabpaint']}, 17:14:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:14:18 INFO - 'tests': ['a11yr', 17:14:18 INFO - 'ts_paint', 17:14:18 INFO - 'tpaint', 17:14:18 INFO - 'sessionrestore', 17:14:18 INFO - 'sessionrestore_no_auto_restore', 17:14:18 INFO - 'tabpaint']}, 17:14:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:14:18 INFO - 'tests': ['tsvgx', 17:14:18 INFO - 'tsvgr_opacity', 17:14:18 INFO - 'tart', 17:14:18 INFO - 'tscrollx', 17:14:18 INFO - 'cart']}, 17:14:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:14:18 INFO - 'tsvgr_opacity', 17:14:18 INFO - 'tart', 17:14:18 INFO - 'tscrollx', 17:14:18 INFO - 'cart']}, 17:14:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:14:18 INFO - 'talos_options': ['--disable-e10s'], 17:14:18 INFO - 'tests': ['tp5o']}, 17:14:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:14:18 INFO - 'tests': ['tp5o']}, 17:14:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:14:18 INFO - 'talos_options': ['--disable-e10s', 17:14:18 INFO - '--xperf_path', 17:14:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:14:18 INFO - 'tests': ['tp5n']}, 17:14:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:14:18 INFO - 'talos_options': ['--xperf_path', 17:14:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:14:18 INFO - 'tests': ['tp5n']}}, 17:14:18 INFO - 'talos.zip': {'path': '', 17:14:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:14:18 INFO - Running post-action listener: _resource_record_post_action 17:14:18 INFO - ##### 17:14:18 INFO - ##### Running create-virtualenv step. 17:14:18 INFO - ##### 17:14:18 INFO - Running pre-action listener: _resource_record_pre_action 17:14:18 INFO - Running main action method: create_virtualenv 17:14:18 INFO - Creating virtualenv /builds/slave/test/build/venv 17:14:18 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:14:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:14:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:14:18 INFO - Using real prefix '/tools/python27' 17:14:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:14:19 INFO - Installing distribute.............................................................................................................................................................................................done. 17:14:22 INFO - Installing pip.................done. 17:14:22 INFO - Return code: 0 17:14:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:14: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:14:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:14:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:14:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:14:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102086a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102096420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa05a56d4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f25e00>, '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 0x101d4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f20b20>, '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.Wt0kMS9d70/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.uRIc258BA9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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:14: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', 'pip>=1.5'] in /builds/slave/test/build 17:14: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 pip>=1.5 17:14:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Wt0kMS9d70/Render', 17:14:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:14:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:14:22 INFO - 'HOME': '/Users/cltbld', 17:14:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:14:22 INFO - 'LOGNAME': 'cltbld', 17:14:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:22 INFO - 'MOZ_NO_REMOTE': '1', 17:14:22 INFO - 'NO_EM_RESTART': '1', 17:14:22 INFO - 'PAGER': '/bin/cat', 17:14:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:14:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:14:22 INFO - 'PWD': '/builds/slave/test', 17:14:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:14:22 INFO - 'SHELL': '/bin/bash', 17:14:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uRIc258BA9/Listeners', 17:14:22 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 17:14:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:14:22 INFO - 'USER': 'cltbld', 17:14:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:14:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:14:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:22 INFO - 'XPC_FLAGS': '0x0', 17:14:22 INFO - 'XPC_SERVICE_NAME': '0', 17:14:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:14:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:14:22 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:14:22 INFO - Cleaning up... 17:14:22 INFO - Return code: 0 17:14:22 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:14: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:14:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:14:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:14:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:14:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14: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', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102086a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102096420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa05a56d4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f25e00>, '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 0x101d4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f20b20>, '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.Wt0kMS9d70/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.uRIc258BA9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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:14: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', 'psutil>=0.7.1'] in /builds/slave/test/build 17:14: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 psutil>=0.7.1 17:14:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Wt0kMS9d70/Render', 17:14:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:14:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:14:22 INFO - 'HOME': '/Users/cltbld', 17:14:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:14:23 INFO - 'LOGNAME': 'cltbld', 17:14:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:23 INFO - 'MOZ_NO_REMOTE': '1', 17:14:23 INFO - 'NO_EM_RESTART': '1', 17:14:23 INFO - 'PAGER': '/bin/cat', 17:14:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:14:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:14:23 INFO - 'PWD': '/builds/slave/test', 17:14:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:14:23 INFO - 'SHELL': '/bin/bash', 17:14:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uRIc258BA9/Listeners', 17:14:23 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 17:14:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:14:23 INFO - 'USER': 'cltbld', 17:14:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:14:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:14:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:23 INFO - 'XPC_FLAGS': '0x0', 17:14:23 INFO - 'XPC_SERVICE_NAME': '0', 17:14:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:14:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:14:23 INFO - Downloading/unpacking psutil>=0.7.1 17:14:23 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:14:23 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:14:23 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:14:23 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:14:23 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:14:23 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:14:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:14:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:14:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:14:25 INFO - Installing collected packages: psutil 17:14:25 INFO - Running setup.py install for psutil 17:14:25 INFO - building 'psutil._psutil_osx' extension 17:14:25 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:14:26 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:14:26 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:14:26 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:14:26 INFO - building 'psutil._psutil_posix' extension 17:14:26 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:14:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:14:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:14:26 INFO - ^ 17:14:26 INFO - 1 warning generated. 17:14:26 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:14:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:14:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:14:26 INFO - Successfully installed psutil 17:14:26 INFO - Cleaning up... 17:14:27 INFO - Return code: 0 17:14:27 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:14:27 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:14:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:14:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:27 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:14:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:14:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:27 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102086a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102096420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa05a56d4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f25e00>, '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 0x101d4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f20b20>, '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.Wt0kMS9d70/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.uRIc258BA9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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:14:27 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.0.0'] in /builds/slave/test/build 17:14:27 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.0.0 17:14:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Wt0kMS9d70/Render', 17:14:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:14:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:14:27 INFO - 'HOME': '/Users/cltbld', 17:14:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:14:27 INFO - 'LOGNAME': 'cltbld', 17:14:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:27 INFO - 'MOZ_NO_REMOTE': '1', 17:14:27 INFO - 'NO_EM_RESTART': '1', 17:14:27 INFO - 'PAGER': '/bin/cat', 17:14:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:14:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:14:27 INFO - 'PWD': '/builds/slave/test', 17:14:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:14:27 INFO - 'SHELL': '/bin/bash', 17:14:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uRIc258BA9/Listeners', 17:14:27 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 17:14:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:14:27 INFO - 'USER': 'cltbld', 17:14:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:14:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:14:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:27 INFO - 'XPC_FLAGS': '0x0', 17:14:27 INFO - 'XPC_SERVICE_NAME': '0', 17:14:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:14:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:14:27 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:14:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:14:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:14:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:29 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:14:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:14:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:14:29 INFO - Installing collected packages: mozsystemmonitor 17:14:29 INFO - Running setup.py install for mozsystemmonitor 17:14:29 INFO - Successfully installed mozsystemmonitor 17:14:29 INFO - Cleaning up... 17:14:29 INFO - Return code: 0 17:14:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:14: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:14:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:14:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:14:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:14:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14: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 0x102086a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102096420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa05a56d4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f25e00>, '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 0x101d4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f20b20>, '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.Wt0kMS9d70/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.uRIc258BA9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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:14: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:14: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:14:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Wt0kMS9d70/Render', 17:14:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:14:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:14:29 INFO - 'HOME': '/Users/cltbld', 17:14:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:14:29 INFO - 'LOGNAME': 'cltbld', 17:14:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:29 INFO - 'MOZ_NO_REMOTE': '1', 17:14:29 INFO - 'NO_EM_RESTART': '1', 17:14:29 INFO - 'PAGER': '/bin/cat', 17:14:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:14:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:14:29 INFO - 'PWD': '/builds/slave/test', 17:14:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:14:29 INFO - 'SHELL': '/bin/bash', 17:14:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uRIc258BA9/Listeners', 17:14:29 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 17:14:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:14:29 INFO - 'USER': 'cltbld', 17:14:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:14:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:14:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:29 INFO - 'XPC_FLAGS': '0x0', 17:14:29 INFO - 'XPC_SERVICE_NAME': '0', 17:14:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:14:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:14:30 INFO - Downloading/unpacking blobuploader==1.2.4 17:14:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:14:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:14:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:32 INFO - Downloading blobuploader-1.2.4.tar.gz 17:14:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:14:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:14: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:14: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:14: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:14: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:14: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:14: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:14:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:14:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:14: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:14: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:14: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:14: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:14: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:14: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:14:33 INFO - Downloading docopt-0.6.1.tar.gz 17:14:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:14:33 INFO - Installing collected packages: blobuploader, requests, docopt 17:14:33 INFO - Running setup.py install for blobuploader 17:14:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:14:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:14:33 INFO - Running setup.py install for requests 17:14:34 INFO - Running setup.py install for docopt 17:14:34 INFO - Successfully installed blobuploader requests docopt 17:14:34 INFO - Cleaning up... 17:14:34 INFO - Return code: 0 17:14:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:14: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:14:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:14:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:14:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14: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 0x102086a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102096420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa05a56d4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f25e00>, '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 0x101d4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f20b20>, '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.Wt0kMS9d70/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.uRIc258BA9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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:14: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:14: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:14:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Wt0kMS9d70/Render', 17:14:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:14:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:14:34 INFO - 'HOME': '/Users/cltbld', 17:14:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:14:34 INFO - 'LOGNAME': 'cltbld', 17:14:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:34 INFO - 'MOZ_NO_REMOTE': '1', 17:14:34 INFO - 'NO_EM_RESTART': '1', 17:14:34 INFO - 'PAGER': '/bin/cat', 17:14:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:14:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:14:34 INFO - 'PWD': '/builds/slave/test', 17:14:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:14:34 INFO - 'SHELL': '/bin/bash', 17:14:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uRIc258BA9/Listeners', 17:14:34 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 17:14:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:14:34 INFO - 'USER': 'cltbld', 17:14:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:14:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:14:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:34 INFO - 'XPC_FLAGS': '0x0', 17:14:34 INFO - 'XPC_SERVICE_NAME': '0', 17:14:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:14:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:14:35 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-9P45wN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:14:35 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-t4SpQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:14:35 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-6JOQhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:14:35 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-XTBWA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:14:35 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-WRKeW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:14:35 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-QnexpX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:14:35 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-2CzGq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:14:35 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-eQ3dRo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:14:35 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-VtgdCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:14:35 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-oplaiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:14:36 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-jwpijy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:14:36 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-xScvwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:14:36 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-_lIrT4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:14:36 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-pn5QWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:14:36 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-DExZqM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:14:36 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-cfzNHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:14:36 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-d8iRWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:14:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:14:36 INFO - Running setup.py install for manifestparser 17:14:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:14:36 INFO - Running setup.py install for mozcrash 17:14:37 INFO - Running setup.py install for mozdebug 17:14:37 INFO - Running setup.py install for mozdevice 17:14:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:14:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:14:37 INFO - Running setup.py install for mozfile 17:14:37 INFO - Running setup.py install for mozhttpd 17:14:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:14:37 INFO - Running setup.py install for mozinfo 17:14:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:14:37 INFO - Running setup.py install for mozInstall 17:14:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:14:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:14:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:14:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:14:37 INFO - Running setup.py install for mozleak 17:14:38 INFO - Running setup.py install for mozlog 17:14:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:14:38 INFO - Running setup.py install for moznetwork 17:14:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:14:38 INFO - Running setup.py install for mozprocess 17:14:38 INFO - Running setup.py install for mozprofile 17:14:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:14:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:14:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:14:38 INFO - Running setup.py install for mozrunner 17:14:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:14:38 INFO - Running setup.py install for mozscreenshot 17:14:39 INFO - Running setup.py install for moztest 17:14:39 INFO - Running setup.py install for mozversion 17:14:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:14:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:14:39 INFO - Cleaning up... 17:14:39 INFO - Return code: 0 17:14:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:14: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:14:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:14:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:14:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14: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 0x102086a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102096420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa05a56d4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f25e00>, '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 0x101d4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f20b20>, '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.Wt0kMS9d70/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.uRIc258BA9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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:14: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:14: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:14:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Wt0kMS9d70/Render', 17:14:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:14:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:14:39 INFO - 'HOME': '/Users/cltbld', 17:14:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:14:39 INFO - 'LOGNAME': 'cltbld', 17:14:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:39 INFO - 'MOZ_NO_REMOTE': '1', 17:14:39 INFO - 'NO_EM_RESTART': '1', 17:14:39 INFO - 'PAGER': '/bin/cat', 17:14:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:14:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:14:39 INFO - 'PWD': '/builds/slave/test', 17:14:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:14:39 INFO - 'SHELL': '/bin/bash', 17:14:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uRIc258BA9/Listeners', 17:14:39 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 17:14:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:14:39 INFO - 'USER': 'cltbld', 17:14:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:14:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:14:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:39 INFO - 'XPC_FLAGS': '0x0', 17:14:39 INFO - 'XPC_SERVICE_NAME': '0', 17:14:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:14:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:14:39 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-wf2N92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:14: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:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:14:39 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-sVrnbB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:14:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:14:39 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-7xPJk2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:14:39 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:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:14:39 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-0B24vJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:14:40 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-v9gWJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:14: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:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:14:40 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-3ZjVN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:14: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:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:14:40 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-mCn1UU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:14: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:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:14:40 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-jZjGXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:14: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:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:14:40 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-nK3ZVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:14: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:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:14:40 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-k7X4JL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:14:40 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-qy34K8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:14: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:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:14:40 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-kMSWLZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:14:40 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-KY49co-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:14:40 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:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:14:40 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-r5vMyW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:14:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:14:41 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-sX7yWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:14: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:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:14:41 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-t9lyI1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:14:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:14:41 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-TnSoxV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:14: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:14: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==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:14: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==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:14: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:14: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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:14: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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:14:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:14: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:14: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:14: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:14: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:14: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:14: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:14:43 INFO - Downloading blessings-1.6.tar.gz 17:14:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:14:43 INFO - Installing collected packages: blessings 17:14:43 INFO - Running setup.py install for blessings 17:14:44 INFO - Successfully installed blessings 17:14:44 INFO - Cleaning up... 17:14:44 INFO - Return code: 0 17:14:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:14:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:14:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:14:44 INFO - Reading from file tmpfile_stdout 17:14:44 INFO - Current package versions: 17:14:44 INFO - blessings == 1.6 17:14:44 INFO - blobuploader == 1.2.4 17:14:44 INFO - docopt == 0.6.1 17:14:44 INFO - manifestparser == 1.1 17:14:44 INFO - mozInstall == 1.12 17:14:44 INFO - mozcrash == 0.17 17:14:44 INFO - mozdebug == 0.1 17:14:44 INFO - mozdevice == 0.48 17:14:44 INFO - mozfile == 1.2 17:14:44 INFO - mozhttpd == 0.7 17:14:44 INFO - mozinfo == 0.9 17:14:44 INFO - mozleak == 0.1 17:14:44 INFO - mozlog == 3.1 17:14:44 INFO - moznetwork == 0.27 17:14:44 INFO - mozprocess == 0.22 17:14:44 INFO - mozprofile == 0.28 17:14:44 INFO - mozrunner == 6.11 17:14:44 INFO - mozscreenshot == 0.1 17:14:44 INFO - mozsystemmonitor == 0.0 17:14:44 INFO - moztest == 0.7 17:14:44 INFO - mozversion == 1.4 17:14:44 INFO - psutil == 3.1.1 17:14:44 INFO - requests == 1.2.3 17:14:44 INFO - wsgiref == 0.1.2 17:14:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:14:44 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:14:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:44 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:14:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:14:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:44 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 0x102086a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102096420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa05a56d4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f25e00>, '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 0x101d4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f20b20>, '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.Wt0kMS9d70/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.uRIc258BA9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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:14:44 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:14:44 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:14:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Wt0kMS9d70/Render', 17:14:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:14:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:14:44 INFO - 'HOME': '/Users/cltbld', 17:14:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:14:44 INFO - 'LOGNAME': 'cltbld', 17:14:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:44 INFO - 'MOZ_NO_REMOTE': '1', 17:14:44 INFO - 'NO_EM_RESTART': '1', 17:14:44 INFO - 'PAGER': '/bin/cat', 17:14:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:14:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:14:44 INFO - 'PWD': '/builds/slave/test', 17:14:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:14:44 INFO - 'SHELL': '/bin/bash', 17:14:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uRIc258BA9/Listeners', 17:14:44 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 17:14:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:14:44 INFO - 'USER': 'cltbld', 17:14:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:14:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:14:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:44 INFO - 'XPC_FLAGS': '0x0', 17:14:44 INFO - 'XPC_SERVICE_NAME': '0', 17:14:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:14:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:14:44 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:14:44 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:14:44 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:14:44 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:14:44 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:14:44 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:14:44 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:14:44 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:14:44 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:14:44 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:14:44 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:14:44 INFO - Cleaning up... 17:14:44 INFO - Return code: 0 17:14:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:14:44 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:14:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:44 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:14:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:14:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:44 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 0x102086a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102096420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa05a56d4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f25e00>, '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 0x101d4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f20b20>, '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.Wt0kMS9d70/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.uRIc258BA9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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:14:44 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:14:44 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:14:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Wt0kMS9d70/Render', 17:14:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:14:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:14:44 INFO - 'HOME': '/Users/cltbld', 17:14:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:14:44 INFO - 'LOGNAME': 'cltbld', 17:14:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:44 INFO - 'MOZ_NO_REMOTE': '1', 17:14:44 INFO - 'NO_EM_RESTART': '1', 17:14:44 INFO - 'PAGER': '/bin/cat', 17:14:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:14:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:14:44 INFO - 'PWD': '/builds/slave/test', 17:14:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:14:44 INFO - 'SHELL': '/bin/bash', 17:14:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uRIc258BA9/Listeners', 17:14:44 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 17:14:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:14:44 INFO - 'USER': 'cltbld', 17:14:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:14:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:14:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:44 INFO - 'XPC_FLAGS': '0x0', 17:14:44 INFO - 'XPC_SERVICE_NAME': '0', 17:14:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:14:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:14:44 INFO - Downloading/unpacking jsonschema 17:14:44 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:14:44 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:14:44 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:14:44 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:14:44 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:14:44 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:14:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:14:47 INFO - Downloading/unpacking functools32 (from jsonschema) 17:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:14:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:47 INFO - Downloading functools32-3.2.3-2.tar.gz 17:14:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:14:47 INFO - warning: no files found matching '*.txt' 17:14:47 INFO - no previously-included directories found matching 'build' 17:14:47 INFO - no previously-included directories found matching 'dist' 17:14:47 INFO - no previously-included directories found matching '.git*' 17:14:47 INFO - Installing collected packages: jsonschema, functools32 17:14:47 INFO - Running setup.py install for functools32 17:14:47 INFO - warning: no files found matching '*.txt' 17:14:47 INFO - no previously-included directories found matching 'build' 17:14:47 INFO - no previously-included directories found matching 'dist' 17:14:47 INFO - no previously-included directories found matching '.git*' 17:14:47 INFO - Successfully installed jsonschema functools32 17:14:47 INFO - Cleaning up... 17:14:48 INFO - Return code: 0 17:14:48 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:14:48 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:14:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:48 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:14:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:14:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:48 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102086a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102096420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa05a56d4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f25e00>, '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 0x101d4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f20b20>, '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.Wt0kMS9d70/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.uRIc258BA9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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:14:48 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', 'flake8'] in /builds/slave/test/build 17:14:48 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 flake8 17:14:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Wt0kMS9d70/Render', 17:14:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:14:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:14:48 INFO - 'HOME': '/Users/cltbld', 17:14:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:14:48 INFO - 'LOGNAME': 'cltbld', 17:14:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:48 INFO - 'MOZ_NO_REMOTE': '1', 17:14:48 INFO - 'NO_EM_RESTART': '1', 17:14:48 INFO - 'PAGER': '/bin/cat', 17:14:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:14:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:14:48 INFO - 'PWD': '/builds/slave/test', 17:14:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:14:48 INFO - 'SHELL': '/bin/bash', 17:14:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uRIc258BA9/Listeners', 17:14:48 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 17:14:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:14:48 INFO - 'USER': 'cltbld', 17:14:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:14:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:14:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:48 INFO - 'XPC_FLAGS': '0x0', 17:14:48 INFO - 'XPC_SERVICE_NAME': '0', 17:14:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:14:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:14:48 INFO - Downloading/unpacking flake8 17:14:48 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:14:48 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:14:48 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:14:48 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:14:48 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:14:48 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:14:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:14:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:14:50 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:14:50 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:14:50 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:14:50 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:14:50 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:14:50 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:14:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:14:51 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:14:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:14:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:14:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:14:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:14:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:14:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:14:51 INFO - no previously-included directories found matching 'docs/_build' 17:14:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:14:52 INFO - Running setup.py install for pep8 17:14:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:14:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:14:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:14:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:14:52 INFO - no previously-included directories found matching 'docs/_build' 17:14:52 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:14:52 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:14:52 INFO - Cleaning up... 17:14:52 INFO - Return code: 0 17:14:52 INFO - Running post-action listener: _resource_record_post_action 17:14:52 INFO - Running post-action listener: _start_resource_monitoring 17:14:52 INFO - Starting resource monitoring. 17:14:52 INFO - ##### 17:14:52 INFO - ##### Running install step. 17:14:52 INFO - ##### 17:14:52 INFO - Running pre-action listener: _resource_record_pre_action 17:14:52 INFO - Running main action method: install 17:14:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:14:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:14:52 INFO - Reading from file tmpfile_stdout 17:14:52 INFO - Detecting whether we're running mozinstall >=1.0... 17:14:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:14:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:14:52 INFO - Reading from file tmpfile_stdout 17:14:52 INFO - Output received: 17:14:52 INFO - Usage: mozinstall [options] installer 17:14:52 INFO - Options: 17:14:52 INFO - -h, --help show this help message and exit 17:14:52 INFO - -d DEST, --destination=DEST 17:14:52 INFO - Directory to install application into. [default: 17:14:52 INFO - "/builds/slave/test"] 17:14:52 INFO - --app=APP Application being installed. [default: firefox] 17:14:52 INFO - mkdir: /builds/slave/test/build/application 17:14:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:14:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 17:15:26 INFO - Reading from file tmpfile_stdout 17:15:26 INFO - Output received: 17:15:26 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:15:26 INFO - Running post-action listener: _resource_record_post_action 17:15:26 INFO - ##### 17:15:26 INFO - ##### Running run-tests step. 17:15:26 INFO - ##### 17:15:26 INFO - Running pre-action listener: _resource_record_pre_action 17:15:26 INFO - Running main action method: run_tests 17:15:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:15:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:15:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:15:26 INFO - 2016-04-18 17:15:26.301 screenresolution[1650:8053] starting screenresolution argv=screenresolution get 17:15:26 INFO - 2016-04-18 17:15:26.303 screenresolution[1650:8053] Display 0: 1600x1200x32@60 17:15:26 INFO - 2016-04-18 17:15:26.309 screenresolution[1651:8055] starting screenresolution argv=screenresolution list 17:15:26 INFO - Available Modes on Display 0 17:15:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:15:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:15:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:15:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:15:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:15:26 INFO - Intel Iris: 17:15:26 INFO - Chipset Model: Intel Iris 17:15:26 INFO - Type: GPU 17:15:26 INFO - Bus: Built-In 17:15:26 INFO - VRAM (Dynamic, Max): 1536 MB 17:15:26 INFO - Vendor: Intel (0x8086) 17:15:26 INFO - Device ID: 0x0a2e 17:15:26 INFO - Revision ID: 0x0009 17:15:26 INFO - Displays: 17:15:26 INFO - Display: 17:15:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:15:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:15:26 INFO - Display Serial Number: 1600x1200 60 17:15:26 INFO - Main Display: Yes 17:15:26 INFO - Mirror: Off 17:15:26 INFO - Online: Yes 17:15:26 INFO - Rotation: Supported 17:15:26 INFO - Return code: 0 17:15:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:15:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:15:26 INFO - Python 2.7.3 17:15:26 INFO - Return code: 0 17:15:26 INFO - grabbing minidump binary from tooltool 17:15:26 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:26 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f25e00>, '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 0x101d4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f20b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:15:26 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:15:26 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:15:26 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:15:26 INFO - Return code: 0 17:15:26 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:15:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:15:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:15:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:15:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:15:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:15:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:15:27 INFO - Return code: 0 17:15:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X5Myv5iTSrioPNtTH8zUxQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0019', '--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:15:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/X5Myv5iTSrioPNtTH8zUxQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0019 --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:15:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Wt0kMS9d70/Render', 17:15:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:15:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:15:27 INFO - 'HOME': '/Users/cltbld', 17:15:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:15:27 INFO - 'LOGNAME': 'cltbld', 17:15:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:15:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:15:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:27 INFO - 'MOZ_NO_REMOTE': '1', 17:15:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:15:27 INFO - 'NO_EM_RESTART': '1', 17:15:27 INFO - 'PAGER': '/bin/cat', 17:15:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:15:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:27 INFO - 'PWD': '/builds/slave/test', 17:15:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:15:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:15:27 INFO - 'SHELL': '/bin/bash', 17:15:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uRIc258BA9/Listeners', 17:15:27 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 17:15:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:15:27 INFO - 'USER': 'cltbld', 17:15:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:15:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:15:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:27 INFO - 'XPC_FLAGS': '0x0', 17:15:27 INFO - 'XPC_SERVICE_NAME': '0', 17:15:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:15:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X5Myv5iTSrioPNtTH8zUxQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0019', '--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:15:28 INFO - mozversion application_buildid: 20160418150833 17:15:28 INFO - mozversion application_changeset: fc2da6172138c3f1eeaea6a29a3f23be6c2cca7c 17:15:28 INFO - mozversion application_display_name: Nightly 17:15:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:15:28 INFO - mozversion application_name: Firefox 17:15:28 INFO - mozversion application_remotingname: firefox 17:15:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:15:28 INFO - mozversion application_vendor: Mozilla 17:15:28 INFO - mozversion application_version: 48.0a1 17:15:28 INFO - mozversion platform_buildid: 20160418150833 17:15:28 INFO - mozversion platform_changeset: fc2da6172138c3f1eeaea6a29a3f23be6c2cca7c 17:15:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:15:28 INFO - mozversion platform_version: 48.0a1 17:15:28 INFO - using testdate: 1461024928 17:15:28 INFO - actual date: 1461024928 17:15:28 INFO - starting webserver on 'localhost:49276' 17:15:28 INFO - SUITE-START | Running 2 tests 17:15:28 INFO - TEST-START | dromaeo_css 17:15:28 INFO - operating with platform_type : mac_ 17:15:28 INFO - Initialising browser for dromaeo_css test... 17:15:28 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/tmpCpQfJE/profile http://localhost:49276/getInfo.html) 17:15:30 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 17:15:30 INFO - PROCESS | 1669 | colorDepth:24 17:15:30 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 17:15:30 INFO - PROCESS | 1669 | __metrics 17:15:30 INFO - PROCESS | 1669 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:15:30 ERROR - PROCESS | 1669 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:15:31 INFO - TEST-INFO | 1669: exit 0 17:15:31 INFO - Browser initialized. 17:15:31 INFO - Running cycle 1/1 for dromaeo_css test... 17:15:31 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/tmpCpQfJE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:15:43 INFO - PROCESS | 1672 | RSS: Main: 237363200 17:15:43 INFO - PROCESS | 1672 | 17:16:34 INFO - PROCESS | 1672 | 1461024994520 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 17:18:45 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 17:18:46 INFO - PROCESS | 1672 | RSS: Main: 379408384 17:18:46 INFO - PROCESS | 1672 | 17:21:49 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 17:21:50 INFO - PROCESS | 1672 | RSS: Main: 370581504 17:21:50 INFO - PROCESS | 1672 | 17:24:52 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 17:24:52 INFO - PROCESS | 1672 | RSS: Main: 375775232 17:24:52 INFO - PROCESS | 1672 | 17:27:55 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 17:27:55 INFO - PROCESS | 1672 | RSS: Main: 375029760 17:27:55 INFO - PROCESS | 1672 | 17:30:58 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 17:30:59 INFO - PROCESS | 1672 | RSS: Main: 338173952 17:30:59 INFO - PROCESS | 1672 | 17:34:02 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 17:34:02 INFO - PROCESS | 1672 | RSS: Main: 383115264 17:34:02 INFO - PROCESS | 1672 | 17:34:02 INFO - PROCESS | 1672 | __start_tp_report 17:34:02 INFO - PROCESS | 1672 | _x_x_mozilla_page_load 17:34:02 INFO - PROCESS | 1672 | _x_x_mozilla_page_load_details 17:34:02 INFO - PROCESS | 1672 | |i|pagename|runs| 17:34:02 INFO - PROCESS | 1672 | |0;dojo.html;3167.287360343922;3419.7606167568265;3444.2250493638926;3447.948280775787;3485.9477107843372;4596.287575425815;5618.719064046802;5641.464060914212;5649.209110724501;5661.830145095643;5689.971550142254;5694.857628559288;5750.884982300351;5834.329052158992;5860.5311575074;5090.770915308802;5114.641975061747;5166.199239117943;5167.534921857032;5251.632385733;5245.291885595434;5246.7901283948595;5257.579393648518;5291.4708529147165;5337.599680023995;5107.157319042353;5111.2333150027425;5136.075506408845;5187.184485430088;5241.318628578299;5170.482951704837;5173.741312934339;5177.58579313654;5179.533841954242;5185.144451165553;5097.23541468779;5150.510701483353;5166.664166829144;5184.092783762826;5205.661631993946;5490.121580547093;5555.666660000413;5594.13290939905;5601.355844077902;5677.176809362661;6195.473384762301;6211.87576248477;6217.2392983785885;6231.376862313778;6278.968605156991;6242.906356404657;6293.087502312185;6320.810375688737;6328.1773369462135;6329.4619957303685;5691.544676425876;5725.942740572583;5790.68151251681;5857.238558987305;5861.501772349313;6257.249130104326;6258.499320054385;6273.215848018997;6278.717457714414;6310.6213627182515;6121.387861213843;6131.325554189036;6136.386361363828;6143.508519318444;6147.323794382614;6033.125196846433;6174.567780255339;6178.165947597106;6196.132541444202;6197.938020619827;6053.606515576474;6058.697065146725;6110.541709371815;6144.2488890665945;6265.8746825063245;6243.250809902841;6251.53113516479;6274.1843560337775;6277.654728989949;6284.685765711788;4885.047415753894;4917.0903382874285;4918.803247870045;4930.161872481615;4956.3804524434445;4359.411479450297;4371.890702732457;4509.616682581952;4512.481064677539;4518.1415531049;5666.744996475169;5668.291463567054;5683.119116536861;5727.570432217601;5738.971305143531;6242.063690446378;6245.437910588069;6267.905981410283;6304.275008374004;6304.464120549805;5512.310961129859;5616.85957851057;5622.690752008597;5633.070543360382;5657;4329.826806927687;4336.609705126553;5280.049591073644;5307.01820163271;5307.442718514578;5374.543163831118;6228.190335256388;6236.438720515175;6256.0303153011355;6266.843328916813;5103.3110530077965;6165.815025549241;6184;6197.101420294122;6203.47270481996;6202.937970620416;6203.4416902479;6224.62652240867;6245.6252624842655;6252.5935814171935;6172.69136543162;6189.535784816067;6191.84520386994;6206.658633775186;6214.223222097238;6267.9373206267355;6305.243370795534;6314.936850631435;6315.147455093504;6316.684165791784;4740.431148262231;5848.444397782204;5962.642241465526;5976.970115149396;6043.697815109315;6032.577719559588;6070.089486577049;6074;6089.725962331617;6098.695065246809;5905.379935106924;5918.674472904032;5919.230500034968;5941.584089113893;5967.731452084753;5814.244148260699;5995.340512543529;6005.3694362091355;6065.090236464565;6105.297890742444;5920.644761314335;5942.881142377042;5958.374370691188;5962.105684147413;5993.460588547052 17:34:02 INFO - PROCESS | 1672 | |1;ext.html;521.4342438454278;527.6122050293034;545.5253929081699;547.414266734594;586.548357764521;25025.37436564087;38377;39456.80271598638;39517.80241098798;39687.80156099216;43888.12223755523;44671.88320291986;44761.55238447615;44765.10469790602;44780;8442.493450392965;9531.475768832712;9720.465374404404;9744.269179811507;9774.804503909918;8375.03687075988;11387.658370248864;11706.882931170665;11747.177697561174;11755.000824929892;11342.48958796852;11460.942695286512;11479.885201147965;11495.3560681043;11543.961043506082;8412;11206.551737930473;11318.830217546743;11415.31508109512;11549.422528873523;9839.704808855675;11336.263142895685;11451.141164412618;11462.885371146349;11498.137639677057;38726;39151.60848391508;39156.825295241186;39165.80417097896;39195.804020979995;3051.709522463957;3379.8141102239365;3402.897913062612;3411.4712219606;3741.7942013189263;27190.320241994108;27965.300867478476;28693.13920582386;28706.569401458994;28715.712842871722;2635.9472810543875;2735.5623100304056;2766.695663477016;2770.6259654946525;2861.856907154634;422982;426584;429239;429699;431081.8445907782;62405;62623;63045;63471;63512.68243658752;66372.668136659;66547.6690466188;66623.6675266492;66728.33271667318;66754.99867501992;17025;17190;17195.22621482011;17195.914020429816;17198.828011719972;11862.822057669142;12180.390980451119;12968.35158242103;13238.933805331104;13349.132306400053;18940.621187576173;19038.904805476162;19073.904630476758;19087.236510539424;19090.427287181406;6792.811258029825;7678;7751.651175697107;7964.681412743541;8062.355011599058;730.7985556658418;1038.127972503101;1055.6516349604613;1085.5766251162054;1090.2041509697806;27938.16185514438;28415.57376639352;28613.71386286152;28745.993890213744;28765.56851647227;1092.1754075672816;1128.7347473343757;1158.9478473468714;1175.9412029398495;1195.7429152732204;14065;14724.411023559152;15023.849761502244;15088.321025553876;15451.84548154504;619298;875607;921213;924942;927741;62307.68846155831;62561.37438625556;63070;63159.05261421082;63173.684131579044;1309.1621362328308;1342.134323361446;1462.6782107936237;1478.9260536973109;1485.6508720450686;26429;30812.383752325277;31241.37517249688;31385.215369615944;32445;54105.45894541004;56901;57807.421925781884;58033.70983145057;58273.417265828495;570445;574223;575004;575165;578110;24247.393815154763;25182.244532664048;27333.589996150473;28253.72858221344;28427.28931776722;42279;42617.78691106525;43048.139037219706;43161.60479940008;43304.133917322106;36211;36820;36823.815880920425;37067.254575540836;37529;31075.68924310728;36159.45760813537;36261.09347266339;36873.44689829709;37011.44482832706;35955.640443596276;36562.26875462422;36704.81647591745;36725.26549469049;37117;31701.682983169874;32062.35875282528;32156.83921580377;32304;32304.35391292208;22844.771552284263;24052.39869003289;24094.759052409954;24512.877435612707;24594.385140371633 17:34:02 INFO - PROCESS | 1672 | |2;jquery.html;393.7342293951583;396.4133083037105;397.46739369245205;398.4640658314566;410.83155906078497;19211.13549890255;19287.324943626976;20224.898875505638;20237.369142011536;20238.494037649067;19156;20123.496912577193;20331.898340508313;20893.37319880406;20894.582108357823;5174.793008279665;6065.423784740443;6072.757089716406;6079.118527813464;6084.665343406111;5724.370319264877;5915.260592425947;6012.518998480111;6022.3074346450285;6024.909626355608;5819.9418005819825;5981.0729336952845;5992.49063829575;5994.580379373446;5997.250343707036;5621.241132447109;5976.3724808895095;5978.461938425541;5993.041113421875;6015.969920150371;5748.770049198027;5758.452946970031;5765.336986246593;5766.279215098113;5771.278590176228;13630.182189068588;13663.111897726616;13746.381412836447;13852.376643051088;13868.86131138696;2032.5833204193252;2079.4281572567666;2149.8172655324315;2323.488832456857;2584.2634849068113;9819.901800982041;10123;10196.694099177037;10289.691309260734;10373.325733827278;1663.4760050584027;1742.4772568229607;1777.6800175968322;1784.7769028871392;1804.6029873427824;126429;127412;127860;129235;130558.3472082643;11480.885191148149;11690.649280521598;11743.354115523729;11757.647270581896;11899.107566932342;15417.691646167013;15420.691586168214;15445.22773861325;15460.5361839145;15464.690706185813;8639.827203455896;8693.261072808755;8732.650693972297;8747.650093996295;8820.33847461443;8521.786955326166;8535.914640853636;8536.274416674652;8614.741557753277;8649.091845356146;4599.425071866017;4628.282616194495;4629.421322334708;4639.628829693616;4701.200795864711;1803.1615298886081;1901.990490047541;1962.8822270663807;1964.224131468062;1966.3117908731829;892.7098692924825;910.740438974889;932.8367535681228;939.7415710679618;959.7600599850037;17227;18082.395518318324;19655.508612284808;20224.089915953817;20795.1681932721;818.7502811642387;928.6517555916531;970.1801977329145;973.2457345557108;1002.7693630465034;10595.046445819913;10900.781984360268;10943.179261555415;10957.56169753201;10958.890411095947;585781;601008;616559;617315;624896.8755156195;127177;128536.71463285435;128685;129809;132565;1001.1440218613127;1016.1210552871713;1019.673704414595;1039.428314427062;1041.1982773264544;18155.636887262444;18287;18414.35549755752;18430.723539146657;18433.354832580797;40845;46306.842328942046;48097.519024809306;49932.500674992785;51059.23411148761;75428;75654.48691026258;75944;76578;78717;7093.929060709327;7988.360931125612;8179.0594081681365;8351.24838764514;8617.48295102296;10069.791625005046;10892.673219803419;11278.379689117177;12934.223946563236;13060.412281447168;10973.23187376876;10989.890101098887;10990.505427255952;11053.447327633425;11340.546378144782;10902.018818306391;10933.070688991525;11064.612738554111;11110.055645270242;11262.436878156223;11073.335599864035;11513.578274760652;11611.709707257387;11692.0061794745;11700.590479333183;7030.367266945999;7590.696372145052;7643.503172293783;7644.273793989562;7972.322352600094;11288.49201785938;11487.94256028748;11590.478428470908;11645.59240426581;11675 17:34:02 INFO - PROCESS | 1672 | |3;mootools.html;1394.2819447984284;1568.215892053973;1582.889197756157;1823.3253696132424;1949.580840119373;7852.332551733102;8176.305014073796;8526.744197674072;8853.690120845771;8866.290696744261;8174.877376839352;8655.523946182957;8673.219410253076;8675;8716.389852710297;2136.102836808544;2351.6472529120597;2424.527217192648;2431.1612493689736;2461.5323088613195;2455.508898220363;2487.577111890983;2487.9674934901996;2489.191012920799;2489.850608963468;2397.736249012607;2448.9142879999204;2450.240425468102;2450.375154335642;2450.571150048743;2046.5395286060666;2118.6292398830296;2433.549793288247;2437.0130097310616;2438.9878050609723;2418.7460316666675;2434.3670645632087;2434.720007199177;2440.9511809763885;2441.7192022917416;8542.14578542147;8583.969923609144;8621.267192288664;8623.965124185139;8626.568671566396;5019.021290848286;5321.148616221425;5325.094733895208;5363.249145119687;5371.57027437804;3374.932501349984;3388.5594872666643;3464.826758662082;3469.774464659789;3473.1838018065732;997.4464172384323;997.6258902911409;1015.8679371681708;1021.9642312519101;1034.9430781307026;10797.40614266215;11381;11400.885991140149;11413.657590272305;11428.657140285888;3841.980790096032;4464.1071785643;4579.893249105382;4671.182543054952;4683.7423941682855;8950.14973577509;8973.685920992733;8976.640934362684;8985.640574376952;8988.460692358349;5218.608604354688;5219.660722053054;5230.660007099526;5271.130263506555;5333.306670132858;4029.657479114308;4356.586124318184;4540.909181816345;4920.237363208708;4921.50784921505;3729.1050147964293;3772.679322257639;3839.1361943563033;3840.558335791364;3911.5501717302873;1053.062774131024;1174.2895548193392;1178.1458442629025;1188.364225139546;1192.0880526397314;812.5896422306815;881.6164968238709;887.40100432208;898.6046139698511;921.8478950973148;5472.890542189213;5500.779968801203;5761.942380576224;5772;5817.534597232211;443.6982851660837;450.12675409705065;455.90426010537493;456.6392549885553;463.4207240948814;3468.809215493172;3508.754387192872;3727.9068023299633;3815.9696881841746;3857.8649747259274;10292.485375731183;10626.681199564026;10831;10832;10837.458127093614;10223.846642300372;10390.636327728493;10770.78458430827;10784.245102842726;10818.404987725751;7396;8034.357251419872;8159.877601835978;8228.8354232915;8232.135625759329;4716;5342.732863356739;5549.361823390362;5864.618799778001;5924.903892779849;9602.423854568748;9864.408135511892;9884.851727223953;9896.802063958536;10003.549840257061;9553.47455889905;10024.749381265527;10033.799324013333;10141.442220677933;10168.542415591168;6795;7092.04257425241;7176.497645164997;7288.052553168054;7543.3965282778345;8235.464694794819;8276.337892968428;8317.419690258832;8326.333893288402;8369.121242269473;7169.4981351304905;7269.273072692688;7318.743843965649;7385.446091543048;7447.143578488326;6004.789832355847;7219.494635375683;7264.67308971087;7273.781786546412;7406.111266648037;6692.6988285526295;6769.898451523132;6787.389134977876;6794.252632210551;6798.694058767466;4718.646101542329;4777.737224452689;4868.294097355934;4925.556699897026;5048.343715317133;4846.588040016638;4874.488178741181;4888.804447822189;4939.110960027229;5105.2086926526445 17:34:02 INFO - PROCESS | 1672 | |4;prototype.html;314.94331020416325;318.7832274053644;323.9692229238222;329.3577523828535;332.2839281348694;5508.862278443036;5889.469947704706;5956.493698035667;5980.342162362137;5987.790427335044;5607.271054762885;5763.933672270622;5855.76576936922;5874.853128671785;5881.941180588193;3623.800690961996;4023.3160362738404;4129.525104612963;4345.804438800245;4383.232934236512;3745.5505339359315;4438.291257865712;4468.932966005513;4476.9776151119195;4483.753393563369;4353.564643535653;4436.401085853417;4436.822527098929;4446.244138496463;4458.843940462085;4216;4234.640055595278;4442.600165985061;4455.2871540553515;4516.322551617251;3854.9229015419533;3866.7486613370324;3872.244912242114;3883.98058009711;3887.4751908492276;5716.8856622867725;5735.397783232784;5743.368229494752;5748.45389687979;5757.424257574251;4636.884077898046;4958.652894297401;5054.632673003478;5201.687898726089;5213.139831927728;5559.19391688207;6232.626042437469;6249.937500624981;6253.937460625381;6286.371362863722;3663.56037275526;4313.741175529478;4316.136772645452;4328.870133895988;4331.133773245332;6172.259328880518;6206.72069756862;6382.425581697669;6478.967605161991;6624.470042396597;4205.581790470492;4240.809163587646;4242.44848169736;4254.31930891056;4258.446401967786;4042.2521833460905;4171.478565179353;4322.783860806947;4339.828246373461;4351.042770590465;4268;4373.300271956536;4583.770811459481;5076.756194732314;5084.694918304914;5316.362036555638;5798.9130163047585;6284.937150628435;6296.65368404733;6343.333949935282;1466.3254902744643;1481.3556103094973;1482.8072350594568;1483.6439254578822;1491.686745783376;874.5758307220992;928.7074571509953;957.1433566957534;965.8647789309503;971.621067783565;5020.347354843847;5065;5802.709864506758;5825.776586916795;5886.911696324559;5378.843548637062;6004.979153543908;6120.5823699638395;6313.305536390993;6462.127612772216;4813.133635945494;5209.739513024334;5590.329160500766;5694.743736531866;5876.971529982236;2887.4080813433197;3395.388830010622;3411.1301618087723;3427.9314413711586;3447.207142357272;6249.625022498664;6460.612363258219;6774.695138718769;6814.386705196457;6836.760713375008;5319.840404787863;5625.915611265835;6576.473882089422;6675.4325882300545;6694.59832410057;5434.2935418395355;5903.734331955158;6389.936100639027;6772.627505487147;6814.250432452525;5120.4111527174855;5624.043912534797;5939.643621382731;6477;6512.837179070371;6168.444839964424;6297.842553936188;6389.463480928593;6421.046318693453;6432.807015789534;5705.115707065412;6471.126397936407;6703.765368212089;6714.731410743516;6877.965610171917;4169.999200191993;4234.597713217239;4269.530351661253;4269.978650106729;4274.166537525152;5012.821986833164;6011.969940150271;6286.497080233662;6565.901511477236;6624.648249871227;5334.573234141182;5637.182608521824;6361.4274715274;6372.36276372359;6425.164728585254;5616.943830561806;5961.582689211714;6171.814845554641;6369.426751592194;6394.296627371078;5744.5978781486565;6219.253689557282;6221;6258.405451482102;6269.62382257066;5673.943260567342;6054.878902421839;6361.268454127835;6362.141110949962;6403.135576697086;5433.483819037185;5515.448455154453;5889.230892228891;6157.230346206724;6267.2792628848265 17:34:02 INFO - PROCESS | 1672 | |5;yui.html;656.1732217406069;671.392389887152;684.3225207045027;690.406250624463;691.1982100763116;13055.73888522229;13372.264525451097;13417.194968301908;13514.864851351484;13607;12467.68830779231;12724.427400766965;12983.80524292134;13136.802947955788;13228.603141905758;722.1154086244335;741.5031928607846;906.8277027364812;907.8093600343935;924.2144177449148;909.1771946388496;914.3279689428265;916.1983264643437;917.3945196170529;917.5274733512247;987.0179171724144;995.5768798260747;996.1532697207352;996.2826764729383;997.9151772099381;762.2034973452727;780.9492382995087;783.4163548156603;784.2549577901017;980.9803803923917;703.8205257659264;731.3929438565978;733.0214164090945;733.296035805622;734.6179986407092;11381.918717721803;12964.611061668165;13035.934820325932;13045.934770326088;13048.934755326163;11551.942240288829;11830.585929492427;11902.047836173086;11927.82108268368;12100.152989290753;9199.448033118035;9266.721998340061;9293.163615274658;9332.066793320682;9583.520823958845;3399.6940275375337;3405.5062016007787;3428.794272343667;3494.2662040971427;3505.8597656093725;71606.283937161;72538.63730681312;73409.6329518349;74947.62526187388;78480;8704.695335663222;8845.292376609856;8850.114988501098;8874.86687699685;9080.22818060459;19695.50761230952;19769.60460790776;19793.40619781409;19795.703064454046;20077.899610501852;6992.895106573405;7035.226125126232;7043.119610048744;7059.5058345915295;7237.89143162853;3864.091938394475;3930.469386632768;3932.8820135395413;3934.6065393460426;3940.5862384449792;3279.967200328014;3379.172102834772;3379.3579219948133;3385.373705864423;3392.728581713457;608.7625825927892;614.3886832601501;617.7714245729109;626.8119564130834;637.8596708724166;465.8812002939297;529.9072662284085;555.4834004375888;580.7705956147382;585.3473377184408;7420.109586849505;7693.846123077619;7701.3068823806125;7906.9209307906185;7916.683332666744;526.1397614899666;578.5892016668129;581.1602234770716;591.8461200087922;607.2561112636985;3590.2460483298278;3591.6767490925417;3613.9277214455565;3616.52985111939;3810.5427348717776;82455.58772206101;88806.11193888108;89570.55214723885;91096.54451727698;96006;72077;77575;79685.80471292936;80212.79680804793;80214;58998.23005309847;64176.037359439644;67639;70113;70333.29666703267;7142.678579463833;7557.093148822177;7714.768556943301;7796;7900.595494865664;42655.14689706251;42983.355249671906;44586.77706611446;45326.32010519779;45386.319205211286;64631;65760;65790.35524111935;66075.67848643096;66648;10308.845367319345;10311.278210525192;10447.582096716047;10574.10120139766;10654.57381704723;10962.725931851768;11417.543298267976;11464.770704586028;11568.826467602825;12176.0867934907;10383.117435018108;10405.739856503647;10519.21105917044;10609.469526523488;10636.946815265874;9250.95374523123;9426.340156189;9553.665621703485;9575.856362154713;9917.553710083208;10529.210309226686;10642.148628109888;10715.785684286426;10925.617603383844;10980.890191098306;9172.587233574372;9271.76820579491;9435.52822358893;9474.478903660365;9642.035796420301;7279.880965457912;8738.169873861973;8992.82014359696;9002.50486223264;9094.909050909671 17:34:02 INFO - PROCESS | 1672 | __end_tp_report 17:34:02 INFO - PROCESS | 1672 | __start_cc_report 17:34:02 INFO - PROCESS | 1672 | _x_x_mozilla_cycle_collect,1599 17:34:02 INFO - PROCESS | 1672 | __end_cc_report 17:34:02 INFO - PROCESS | 1672 | __startTimestamp1461026042772__endTimestamp 17:34:02 INFO - PROCESS | 1672 | 17:34:02 INFO - PROCESS | 1672 | ------- Summary: start ------- 17:34:02 INFO - PROCESS | 1672 | Number of tests: 6 17:34:02 INFO - PROCESS | 1672 | 17:34:02 INFO - PROCESS | 1672 | [#0] dojo.html Cycles:165 Average:5687.44 Median:5919.23 stddev:657.94 (11.1%) stddev-sans-first:629.55 17:34:02 INFO - PROCESS | 1672 | Values: 3167.3 3419.8 3444.2 3447.9 3485.9 4596.3 5618.7 5641.5 5649.2 5661.8 5690.0 5694.9 5750.9 5834.3 5860.5 5090.8 5114.6 5166.2 5167.5 5251.6 5245.3 5246.8 5257.6 5291.5 5337.6 5107.2 5111.2 5136.1 5187.2 5241.3 5170.5 5173.7 5177.6 5179.5 5185.1 5097.2 5150.5 5166.7 5184.1 5205.7 5490.1 5555.7 5594.1 5601.4 5677.2 6195.5 6211.9 6217.2 6231.4 6279.0 6242.9 6293.1 6320.8 6328.2 6329.5 5691.5 5725.9 5790.7 5857.2 5861.5 6257.2 6258.5 6273.2 6278.7 6310.6 6121.4 6131.3 6136.4 6143.5 6147.3 6033.1 6174.6 6178.2 6196.1 6197.9 6053.6 6058.7 6110.5 6144.2 6265.9 6243.3 6251.5 6274.2 6277.7 6284.7 4885.0 4917.1 4918.8 4930.2 4956.4 4359.4 4371.9 4509.6 4512.5 4518.1 5666.7 5668.3 5683.1 5727.6 5739.0 6242.1 6245.4 6267.9 6304.3 6304.5 5512.3 5616.9 5622.7 5633.1 5657.0 4329.8 4336.6 5280.0 5307.0 5307.4 5374.5 6228.2 6236.4 6256.0 6266.8 5103.3 6165.8 6184.0 6197.1 6203.5 6202.9 6203.4 6224.6 6245.6 6252.6 6172.7 6189.5 6191.8 6206.7 6214.2 6267.9 6305.2 6314.9 6315.1 6316.7 4740.4 5848.4 5962.6 5977.0 6043.7 6032.6 6070.1 6074.0 6089.7 6098.7 5905.4 5918.7 5919.2 5941.6 5967.7 5814.2 5995.3 6005.4 6065.1 6105.3 5920.6 5942.9 5958.4 5962.1 5993.5 17:34:02 INFO - PROCESS | 1672 | 17:34:02 INFO - PROCESS | 1672 | [#1] ext.html Cycles:180 Average:74534.09 Median:3407.18 stddev:174423.75 (5119.3%) stddev-sans-first:174824.53 17:34:02 INFO - PROCESS | 1672 | Values: 521.4 527.6 545.5 547.4 586.5 25025.4 38377.0 39456.8 39517.8 39687.8 43888.1 44671.9 44761.6 44765.1 44780.0 8442.5 9531.5 9720.5 9744.3 9774.8 8375.0 11387.7 11706.9 11747.2 11755.0 11342.5 11460.9 11479.9 11495.4 11544.0 8412.0 11206.6 11318.8 11415.3 11549.4 9839.7 11336.3 11451.1 11462.9 11498.1 38726.0 39151.6 39156.8 39165.8 39195.8 3051.7 3379.8 3402.9 3411.5 3741.8 27190.3 27965.3 28693.1 28706.6 28715.7 2635.9 2735.6 2766.7 2770.6 2861.9 422982.0 426584.0 429239.0 429699.0 431081.8 62405.0 62623.0 63045.0 63471.0 63512.7 66372.7 66547.7 66623.7 66728.3 66755.0 17025.0 17190.0 17195.2 17195.9 17198.8 11862.8 12180.4 12968.4 13238.9 13349.1 18940.6 19038.9 19073.9 19087.2 19090.4 6792.8 7678.0 7751.7 7964.7 8062.4 730.8 1038.1 1055.7 1085.6 1090.2 27938.2 28415.6 28613.7 28746.0 28765.6 1092.2 1128.7 1158.9 1175.9 1195.7 14065.0 14724.4 15023.8 15088.3 15451.8 619298.0 875607.0 921213.0 924942.0 927741.0 62307.7 62561.4 63070.0 63159.1 63173.7 1309.2 1342.1 1462.7 1478.9 1485.7 26429.0 30812.4 31241.4 31385.2 32445.0 54105.5 56901.0 57807.4 58033.7 58273.4 570445.0 574223.0 575004.0 575165.0 578110.0 24247.4 25182.2 27333.6 28253.7 28427.3 42279.0 42617.8 43048.1 43161.6 43304.1 36211.0 36820.0 36823.8 37067.3 37529.0 31075.7 36159.5 36261.1 36873.4 37011.4 35955.6 36562.3 36704.8 36725.3 37117.0 31701.7 32062.4 32156.8 32304.0 32304.4 22844.8 24052.4 24094.8 24512.9 24594.4 17:34:02 INFO - PROCESS | 1672 | 17:34:02 INFO - PROCESS | 1672 | [#2] jquery.html Cycles:180 Average:35087.05 Median:11135.54 stddev:101883.77 (914.9%) stddev-sans-first:102136.27 17:34:02 INFO - PROCESS | 1672 | Values: 393.7 396.4 397.5 398.5 410.8 19211.1 19287.3 20224.9 20237.4 20238.5 19156.0 20123.5 20331.9 20893.4 20894.6 5174.8 6065.4 6072.8 6079.1 6084.7 5724.4 5915.3 6012.5 6022.3 6024.9 5819.9 5981.1 5992.5 5994.6 5997.3 5621.2 5976.4 5978.5 5993.0 6016.0 5748.8 5758.5 5765.3 5766.3 5771.3 13630.2 13663.1 13746.4 13852.4 13868.9 2032.6 2079.4 2149.8 2323.5 2584.3 9819.9 10123.0 10196.7 10289.7 10373.3 1663.5 1742.5 1777.7 1784.8 1804.6 126429.0 127412.0 127860.0 129235.0 130558.3 11480.9 11690.6 11743.4 11757.6 11899.1 15417.7 15420.7 15445.2 15460.5 15464.7 8639.8 8693.3 8732.7 8747.7 8820.3 8521.8 8535.9 8536.3 8614.7 8649.1 4599.4 4628.3 4629.4 4639.6 4701.2 1803.2 1902.0 1962.9 1964.2 1966.3 892.7 910.7 932.8 939.7 959.8 17227.0 18082.4 19655.5 20224.1 20795.2 818.8 928.7 970.2 973.2 1002.8 10595.0 10900.8 10943.2 10957.6 10958.9 585781.0 601008.0 616559.0 617315.0 624896.9 127177.0 128536.7 128685.0 129809.0 132565.0 1001.1 1016.1 1019.7 1039.4 1041.2 18155.6 18287.0 18414.4 18430.7 18433.4 40845.0 46306.8 48097.5 49932.5 51059.2 75428.0 75654.5 75944.0 76578.0 78717.0 7093.9 7988.4 8179.1 8351.2 8617.5 10069.8 10892.7 11278.4 12934.2 13060.4 10973.2 10989.9 10990.5 11053.4 11340.5 10902.0 10933.1 11064.6 11110.1 11262.4 11073.3 11513.6 11611.7 11692.0 11700.6 7030.4 7590.7 7643.5 7644.3 7972.3 11288.5 11487.9 11590.5 11645.6 11675.0 17:34:02 INFO - PROCESS | 1672 | 17:34:02 INFO - PROCESS | 1672 | [#3] mootools.html Cycles:180 Average:5561.46 Median:4871.39 stddev:3138.41 (64.4%) stddev-sans-first:3131.59 17:34:02 INFO - PROCESS | 1672 | Values: 1394.3 1568.2 1582.9 1823.3 1949.6 7852.3 8176.3 8526.7 8853.7 8866.3 8174.9 8655.5 8673.2 8675.0 8716.4 2136.1 2351.6 2424.5 2431.2 2461.5 2455.5 2487.6 2488.0 2489.2 2489.9 2397.7 2448.9 2450.2 2450.4 2450.6 2046.5 2118.6 2433.5 2437.0 2439.0 2418.7 2434.4 2434.7 2441.0 2441.7 8542.1 8584.0 8621.3 8624.0 8626.6 5019.0 5321.1 5325.1 5363.2 5371.6 3374.9 3388.6 3464.8 3469.8 3473.2 997.4 997.6 1015.9 1022.0 1034.9 10797.4 11381.0 11400.9 11413.7 11428.7 3842.0 4464.1 4579.9 4671.2 4683.7 8950.1 8973.7 8976.6 8985.6 8988.5 5218.6 5219.7 5230.7 5271.1 5333.3 4029.7 4356.6 4540.9 4920.2 4921.5 3729.1 3772.7 3839.1 3840.6 3911.6 1053.1 1174.3 1178.1 1188.4 1192.1 812.6 881.6 887.4 898.6 921.8 5472.9 5500.8 5761.9 5772.0 5817.5 443.7 450.1 455.9 456.6 463.4 3468.8 3508.8 3727.9 3816.0 3857.9 10292.5 10626.7 10831.0 10832.0 10837.5 10223.8 10390.6 10770.8 10784.2 10818.4 7396.0 8034.4 8159.9 8228.8 8232.1 4716.0 5342.7 5549.4 5864.6 5924.9 9602.4 9864.4 9884.9 9896.8 10003.5 9553.5 10024.7 10033.8 10141.4 10168.5 6795.0 7092.0 7176.5 7288.1 7543.4 8235.5 8276.3 8317.4 8326.3 8369.1 7169.5 7269.3 7318.7 7385.4 7447.1 6004.8 7219.5 7264.7 7273.8 7406.1 6692.7 6769.9 6787.4 6794.3 6798.7 4718.6 4777.7 4868.3 4925.6 5048.3 4846.6 4874.5 4888.8 4939.1 5105.2 17:34:02 INFO - PROCESS | 1672 | 17:34:02 INFO - PROCESS | 1672 | [#4] prototype.html Cycles:180 Average:5025.35 Median:5655.56 stddev:1564.12 (27.7%) stddev-sans-first:1528.03 17:34:02 INFO - PROCESS | 1672 | Values: 314.9 318.8 324.0 329.4 332.3 5508.9 5889.5 5956.5 5980.3 5987.8 5607.3 5763.9 5855.8 5874.9 5881.9 3623.8 4023.3 4129.5 4345.8 4383.2 3745.6 4438.3 4468.9 4477.0 4483.8 4353.6 4436.4 4436.8 4446.2 4458.8 4216.0 4234.6 4442.6 4455.3 4516.3 3854.9 3866.7 3872.2 3884.0 3887.5 5716.9 5735.4 5743.4 5748.5 5757.4 4636.9 4958.7 5054.6 5201.7 5213.1 5559.2 6232.6 6249.9 6253.9 6286.4 3663.6 4313.7 4316.1 4328.9 4331.1 6172.3 6206.7 6382.4 6479.0 6624.5 4205.6 4240.8 4242.4 4254.3 4258.4 4042.3 4171.5 4322.8 4339.8 4351.0 4268.0 4373.3 4583.8 5076.8 5084.7 5316.4 5798.9 6284.9 6296.7 6343.3 1466.3 1481.4 1482.8 1483.6 1491.7 874.6 928.7 957.1 965.9 971.6 5020.3 5065.0 5802.7 5825.8 5886.9 5378.8 6005.0 6120.6 6313.3 6462.1 4813.1 5209.7 5590.3 5694.7 5877.0 2887.4 3395.4 3411.1 3427.9 3447.2 6249.6 6460.6 6774.7 6814.4 6836.8 5319.8 5625.9 6576.5 6675.4 6694.6 5434.3 5903.7 6389.9 6772.6 6814.3 5120.4 5624.0 5939.6 6477.0 6512.8 6168.4 6297.8 6389.5 6421.0 6432.8 5705.1 6471.1 6703.8 6714.7 6878.0 4170.0 4234.6 4269.5 4270.0 4274.2 5012.8 6012.0 6286.5 6565.9 6624.6 5334.6 5637.2 6361.4 6372.4 6425.2 5616.9 5961.6 6171.8 6369.4 6394.3 5744.6 6219.3 6221.0 6258.4 6269.6 5673.9 6054.9 6361.3 6362.1 6403.1 5433.5 5515.4 5889.2 6157.2 6267.3 17:34:02 INFO - PROCESS | 1672 | 17:34:02 INFO - PROCESS | 1672 | [#5] yui.html Cycles:180 Average:17254.90 Median:65933.02 stddev:24658.44 (37.4%) stddev-sans-first:24696.12 17:34:02 INFO - PROCESS | 1672 | Values: 656.2 671.4 684.3 690.4 691.2 13055.7 13372.3 13417.2 13514.9 13607.0 12467.7 12724.4 12983.8 13136.8 13228.6 722.1 741.5 906.8 907.8 924.2 909.2 914.3 916.2 917.4 917.5 987.0 995.6 996.2 996.3 997.9 762.2 780.9 783.4 784.3 981.0 703.8 731.4 733.0 733.3 734.6 11381.9 12964.6 13035.9 13045.9 13048.9 11551.9 11830.6 11902.0 11927.8 12100.2 9199.4 9266.7 9293.2 9332.1 9583.5 3399.7 3405.5 3428.8 3494.3 3505.9 71606.3 72538.6 73409.6 74947.6 78480.0 8704.7 8845.3 8850.1 8874.9 9080.2 19695.5 19769.6 19793.4 19795.7 20077.9 6992.9 7035.2 7043.1 7059.5 7237.9 3864.1 3930.5 3932.9 3934.6 3940.6 3280.0 3379.2 3379.4 3385.4 3392.7 608.8 614.4 617.8 626.8 637.9 465.9 529.9 555.5 580.8 585.3 7420.1 7693.8 7701.3 7906.9 7916.7 526.1 578.6 581.2 591.8 607.3 3590.2 3591.7 3613.9 3616.5 3810.5 82455.6 88806.1 89570.6 91096.5 96006.0 72077.0 77575.0 79685.8 80212.8 80214.0 58998.2 64176.0 67639.0 70113.0 70333.3 7142.7 7557.1 7714.8 7796.0 7900.6 42655.1 42983.4 44586.8 45326.3 45386.3 64631.0 65760.0 65790.4 66075.7 66648.0 10308.8 10311.3 10447.6 10574.1 10654.6 10962.7 11417.5 11464.8 11568.8 12176.1 10383.1 10405.7 10519.2 10609.5 10636.9 9251.0 9426.3 9553.7 9575.9 9917.6 10529.2 10642.1 10715.8 10925.6 10980.9 9172.6 9271.8 9435.5 9474.5 9642.0 7279.9 8738.2 8992.8 9002.5 9094.9 17:34:02 INFO - PROCESS | 1672 | -------- Summary: end -------- 17:34:02 INFO - PROCESS | 1672 | 17:34:03 INFO - TEST-INFO | 1672: exit 0 17:34:03 INFO - TEST-OK | dromaeo_css | took 1115294ms 17:34:03 INFO - TEST-START | kraken 17:34:03 INFO - operating with platform_type : mac_ 17:34:03 INFO - Initialising browser for kraken test... 17:34:03 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/tmpqFEliO/profile http://localhost:49276/getInfo.html) 17:34:05 INFO - PROCESS | 1678 | __metrics Screen width/height:1600/1200 17:34:05 INFO - PROCESS | 1678 | colorDepth:24 17:34:05 INFO - PROCESS | 1678 | Browser inner width/height: 1024/689 17:34:05 INFO - PROCESS | 1678 | __metrics 17:34:05 INFO - PROCESS | 1678 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:34:05 ERROR - PROCESS | 1678 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:34:06 INFO - TEST-INFO | 1678: exit 0 17:34:06 INFO - Browser initialized. 17:34:06 INFO - Running cycle 1/1 for kraken test... 17:34:06 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/tmpqFEliO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:34:18 INFO - PROCESS | 1680 | RSS: Main: 237486080 17:34:18 INFO - PROCESS | 1680 | 17:34:21 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 17:34:21 INFO - PROCESS | 1680 | RSS: Main: 286556160 17:34:21 INFO - PROCESS | 1680 | 17:34:24 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 17:34:25 INFO - PROCESS | 1680 | RSS: Main: 301510656 17:34:25 INFO - PROCESS | 1680 | 17:34:28 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 17:34:29 INFO - PROCESS | 1680 | RSS: Main: 387088384 17:34:29 INFO - PROCESS | 1680 | 17:34:31 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 17:34:31 INFO - PROCESS | 1680 | RSS: Main: 287100928 17:34:31 INFO - PROCESS | 1680 | 17:34:34 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:34:34 INFO - PROCESS | 1680 | RSS: Main: 291385344 17:34:34 INFO - PROCESS | 1680 | 17:34:37 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 17:34:38 INFO - PROCESS | 1680 | RSS: Main: 328093696 17:34:38 INFO - PROCESS | 1680 | 17:34:41 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 17:34:41 INFO - PROCESS | 1680 | RSS: Main: 327385088 17:34:41 INFO - PROCESS | 1680 | 17:34:44 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 17:34:45 INFO - PROCESS | 1680 | RSS: Main: 326586368 17:34:45 INFO - PROCESS | 1680 | 17:34:46 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:34:47 INFO - PROCESS | 1680 | RSS: Main: 320278528 17:34:47 INFO - PROCESS | 1680 | 17:34:48 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:34:49 INFO - PROCESS | 1680 | RSS: Main: 327024640 17:34:49 INFO - PROCESS | 1680 | 17:34:51 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:34:52 INFO - PROCESS | 1680 | RSS: Main: 330375168 17:34:52 INFO - PROCESS | 1680 | 17:34:55 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:34:55 INFO - PROCESS | 1680 | RSS: Main: 334950400 17:34:55 INFO - PROCESS | 1680 | 17:34:58 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:34:59 INFO - PROCESS | 1680 | RSS: Main: 332660736 17:34:59 INFO - PROCESS | 1680 | 17:35:01 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 17:35:01 INFO - PROCESS | 1680 | RSS: Main: 397586432 17:35:01 INFO - PROCESS | 1680 | 17:35:01 INFO - PROCESS | 1680 | __start_tp_report 17:35:01 INFO - PROCESS | 1680 | _x_x_mozilla_page_load 17:35:01 INFO - PROCESS | 1680 | _x_x_mozilla_page_load_details 17:35:01 INFO - PROCESS | 1680 | |i|pagename|runs| 17:35:01 INFO - PROCESS | 1680 | |0;ai-astar;112;111;111;113;114;163;169;113;113;112 17:35:01 INFO - PROCESS | 1680 | |1;audio-beat-detection;180;148;145;169;120;150;145;120;172;118 17:35:01 INFO - PROCESS | 1680 | |2;audio-dft;185;184;187;185;184;183;206;182;183;186 17:35:01 INFO - PROCESS | 1680 | |3;audio-fft;77;74;87;90;55;58;56;78;84;56 17:35:01 INFO - PROCESS | 1680 | |4;audio-oscillator;89;100;136;79;77;77;125;79;76;123 17:35:01 INFO - PROCESS | 1680 | |5;imaging-gaussian-blur;88;90;133;124;89;86;90;102;89;84 17:35:01 INFO - PROCESS | 1680 | |6;imaging-darkroom;94;95;96;94;94;94;95;94;94;95 17:35:01 INFO - PROCESS | 1680 | |7;imaging-desaturate;84;86;84;86;86;85;86;83;85;86 17:35:01 INFO - PROCESS | 1680 | |8;json-parse-financial;57;59;58;58;58;58;57;76;59;57 17:35:01 INFO - PROCESS | 1680 | |9;json-stringify-tinderbox;65;70;63;72;70;66;66;68;67;67 17:35:01 INFO - PROCESS | 1680 | |10;stanford-crypto-aes;82;80;82;81;81;82;75;78;82;82 17:35:01 INFO - PROCESS | 1680 | |11;stanford-crypto-ccm;140;138;137;135;140;136;138;138;176;145 17:35:01 INFO - PROCESS | 1680 | |12;stanford-crypto-pbkdf2;182;169;169;200;166;166;169;173;169;168 17:35:01 INFO - PROCESS | 1680 | |13;stanford-crypto-sha256-iterative;68;70;95;94;83;67;69;69;69;66 17:35:01 INFO - PROCESS | 1680 | __end_tp_report 17:35:01 INFO - PROCESS | 1680 | __start_cc_report 17:35:01 INFO - PROCESS | 1680 | _x_x_mozilla_cycle_collect,1988 17:35:01 INFO - PROCESS | 1680 | __end_cc_report 17:35:01 INFO - PROCESS | 1680 | __startTimestamp1461026101408__endTimestamp 17:35:01 INFO - PROCESS | 1680 | 17:35:01 INFO - PROCESS | 1680 | ------- Summary: start ------- 17:35:01 INFO - PROCESS | 1680 | Number of tests: 14 17:35:01 INFO - PROCESS | 1680 | 17:35:01 INFO - PROCESS | 1680 | [#0] ai-astar Cycles:10 Average:123.10 Median:113.00 stddev:22.67 (20.1%) stddev-sans-first:23.69 17:35:01 INFO - PROCESS | 1680 | Values: 112.0 111.0 111.0 113.0 114.0 163.0 169.0 113.0 113.0 112.0 17:35:01 INFO - PROCESS | 1680 | 17:35:01 INFO - PROCESS | 1680 | [#1] audio-beat-detection Cycles:10 Average:146.70 Median:149.00 stddev:22.40 (15.0%) stddev-sans-first:20.25 17:35:01 INFO - PROCESS | 1680 | Values: 180.0 148.0 145.0 169.0 120.0 150.0 145.0 120.0 172.0 118.0 17:35:01 INFO - PROCESS | 1680 | 17:35:01 INFO - PROCESS | 1680 | [#2] audio-dft Cycles:10 Average:186.50 Median:185.00 stddev:7.01 (3.8%) stddev-sans-first:7.42 17:35:01 INFO - PROCESS | 1680 | Values: 185.0 184.0 187.0 185.0 184.0 183.0 206.0 182.0 183.0 186.0 17:35:01 INFO - PROCESS | 1680 | 17:35:01 INFO - PROCESS | 1680 | [#3] audio-fft Cycles:10 Average:71.50 Median:77.50 stddev:13.95 (18.0%) stddev-sans-first:14.66 17:35:01 INFO - PROCESS | 1680 | Values: 77.0 74.0 87.0 90.0 55.0 58.0 56.0 78.0 84.0 56.0 17:35:01 INFO - PROCESS | 1680 | 17:35:01 INFO - PROCESS | 1680 | [#4] audio-oscillator Cycles:10 Average:96.10 Median:77.00 stddev:23.42 (30.4%) stddev-sans-first:24.70 17:35:01 INFO - PROCESS | 1680 | Values: 89.0 100.0 136.0 79.0 77.0 77.0 125.0 79.0 76.0 123.0 17:35:01 INFO - PROCESS | 1680 | 17:35:01 INFO - PROCESS | 1680 | [#5] imaging-gaussian-blur Cycles:10 Average:97.50 Median:88.50 stddev:17.14 (19.4%) stddev-sans-first:17.83 17:35:01 INFO - PROCESS | 1680 | Values: 88.0 90.0 133.0 124.0 89.0 86.0 90.0 102.0 89.0 84.0 17:35:01 INFO - PROCESS | 1680 | 17:35:01 INFO - PROCESS | 1680 | [#6] imaging-darkroom Cycles:10 Average:94.50 Median:94.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 17:35:01 INFO - PROCESS | 1680 | Values: 94.0 95.0 96.0 94.0 94.0 94.0 95.0 94.0 94.0 95.0 17:35:01 INFO - PROCESS | 1680 | 17:35:01 INFO - PROCESS | 1680 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:86.00 stddev:1.10 (1.3%) stddev-sans-first:1.09 17:35:01 INFO - PROCESS | 1680 | Values: 84.0 86.0 84.0 86.0 86.0 85.0 86.0 83.0 85.0 86.0 17:35:01 INFO - PROCESS | 1680 | 17:35:01 INFO - PROCESS | 1680 | [#8] json-parse-financial Cycles:10 Average:59.70 Median:58.00 stddev:5.77 (10.0%) stddev-sans-first:6.04 17:35:01 INFO - PROCESS | 1680 | Values: 57.0 59.0 58.0 58.0 58.0 58.0 57.0 76.0 59.0 57.0 17:35:01 INFO - PROCESS | 1680 | 17:35:01 INFO - PROCESS | 1680 | [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:67.50 stddev:2.67 (4.0%) stddev-sans-first:2.69 17:35:01 INFO - PROCESS | 1680 | Values: 65.0 70.0 63.0 72.0 70.0 66.0 66.0 68.0 67.0 67.0 17:35:01 INFO - PROCESS | 1680 | 17:35:01 INFO - PROCESS | 1680 | [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:82.00 stddev:2.32 (2.8%) stddev-sans-first:2.40 17:35:01 INFO - PROCESS | 1680 | Values: 82.0 80.0 82.0 81.0 81.0 82.0 75.0 78.0 82.0 82.0 17:35:01 INFO - PROCESS | 1680 | 17:35:01 INFO - PROCESS | 1680 | [#11] stanford-crypto-ccm Cycles:10 Average:142.30 Median:139.00 stddev:12.16 (8.7%) stddev-sans-first:12.87 17:35:01 INFO - PROCESS | 1680 | Values: 140.0 138.0 137.0 135.0 140.0 136.0 138.0 138.0 176.0 145.0 17:35:01 INFO - PROCESS | 1680 | 17:35:01 INFO - PROCESS | 1680 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.10 Median:169.00 stddev:10.52 (6.2%) stddev-sans-first:10.66 17:35:01 INFO - PROCESS | 1680 | Values: 182.0 169.0 169.0 200.0 166.0 166.0 169.0 173.0 169.0 168.0 17:35:01 INFO - PROCESS | 1680 | 17:35:01 INFO - PROCESS | 1680 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.00 Median:69.50 stddev:11.31 (16.3%) stddev-sans-first:11.71 17:35:01 INFO - PROCESS | 1680 | Values: 68.0 70.0 95.0 94.0 83.0 67.0 69.0 69.0 69.0 66.0 17:35:01 INFO - PROCESS | 1680 | -------- Summary: end -------- 17:35:01 INFO - PROCESS | 1680 | 17:35:02 INFO - TEST-INFO | 1680: exit 0 17:35:02 INFO - TEST-OK | kraken | took 58814ms 17:35:02 INFO - SUITE-END | took 1174s 17:35:02 INFO - Completed test suite (00:19:34) 17:35:02 INFO - javascript benchmark 17:35:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3167.287360343922, 3419.7606167568265, 3444.2250493638926, 3447.948280775787, 3485.9477107843372, 4596.287575425815, 5618.719064046802, 5641.464060914212, 5649.209110724501, 5661.830145095643, 5689.971550142254, 5694.857628559288, 5750.884982300351, 5834.329052158992, 5860.5311575074, 5090.770915308802, 5114.641975061747, 5166.199239117943, 5167.534921857032, 5251.632385733, 5245.291885595434, 5246.7901283948595, 5257.579393648518, 5291.4708529147165, 5337.599680023995, 5107.157319042353, 5111.2333150027425, 5136.075506408845, 5187.184485430088, 5241.318628578299, 5170.482951704837, 5173.741312934339, 5177.58579313654, 5179.533841954242, 5185.144451165553, 5097.23541468779, 5150.510701483353, 5166.664166829144, 5184.092783762826, 5205.661631993946, 5490.121580547093, 5555.666660000413, 5594.13290939905, 5601.355844077902, 5677.176809362661, 6195.473384762301, 6211.87576248477, 6217.2392983785885, 6231.376862313778, 6278.968605156991, 6242.906356404657, 6293.087502312185, 6320.810375688737, 6328.1773369462135, 6329.4619957303685, 5691.544676425876, 5725.942740572583, 5790.68151251681, 5857.238558987305, 5861.501772349313, 6257.249130104326, 6258.499320054385, 6273.215848018997, 6278.717457714414, 6310.6213627182515, 6121.387861213843, 6131.325554189036, 6136.386361363828, 6143.508519318444, 6147.323794382614, 6033.125196846433, 6174.567780255339, 6178.165947597106, 6196.132541444202, 6197.938020619827, 6053.606515576474, 6058.697065146725, 6110.541709371815, 6144.2488890665945, 6265.8746825063245, 6243.250809902841, 6251.53113516479, 6274.1843560337775, 6277.654728989949, 6284.685765711788, 4885.047415753894, 4917.0903382874285, 4918.803247870045, 4930.161872481615, 4956.3804524434445, 4359.411479450297, 4371.890702732457, 4509.616682581952, 4512.481064677539, 4518.1415531049, 5666.744996475169, 5668.291463567054, 5683.119116536861, 5727.570432217601, 5738.971305143531, 6242.063690446378, 6245.437910588069, 6267.905981410283, 6304.275008374004, 6304.464120549805, 5512.310961129859, 5616.85957851057, 5622.690752008597, 5633.070543360382, 5657.0, 4329.826806927687, 4336.609705126553, 5280.049591073644, 5307.01820163271, 5307.442718514578, 5374.543163831118, 6228.190335256388, 6236.438720515175, 6256.0303153011355, 6266.843328916813, 5103.3110530077965, 6165.815025549241, 6184.0, 6197.101420294122, 6203.47270481996, 6202.937970620416, 6203.4416902479, 6224.62652240867, 6245.6252624842655, 6252.5935814171935, 6172.69136543162, 6189.535784816067, 6191.84520386994, 6206.658633775186, 6214.223222097238, 6267.9373206267355, 6305.243370795534, 6314.936850631435, 6315.147455093504, 6316.684165791784, 4740.431148262231, 5848.444397782204, 5962.642241465526, 5976.970115149396, 6043.697815109315, 6032.577719559588, 6070.089486577049, 6074.0, 6089.725962331617, 6098.695065246809, 5905.379935106924, 5918.674472904032, 5919.230500034968, 5941.584089113893, 5967.731452084753, 5814.244148260699, 5995.340512543529, 6005.3694362091355, 6065.090236464565, 6105.297890742444, 5920.644761314335, 5942.881142377042, 5958.374370691188, 5962.105684147413, 5993.460588547052], "value": 5646.352852282288, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [521.4342438454278, 527.6122050293034, 545.5253929081699, 547.414266734594, 586.548357764521, 25025.37436564087, 38377.0, 39456.80271598638, 39517.80241098798, 39687.80156099216, 43888.12223755523, 44671.88320291986, 44761.55238447615, 44765.10469790602, 44780.0, 8442.493450392965, 9531.475768832712, 9720.465374404404, 9744.269179811507, 9774.804503909918, 8375.03687075988, 11387.658370248864, 11706.882931170665, 11747.177697561174, 11755.000824929892, 11342.48958796852, 11460.942695286512, 11479.885201147965, 11495.3560681043, 11543.961043506082, 8412.0, 11206.551737930473, 11318.830217546743, 11415.31508109512, 11549.422528873523, 9839.704808855675, 11336.263142895685, 11451.141164412618, 11462.885371146349, 11498.137639677057, 38726.0, 39151.60848391508, 39156.825295241186, 39165.80417097896, 39195.804020979995, 3051.709522463957, 3379.8141102239365, 3402.897913062612, 3411.4712219606, 3741.7942013189263, 27190.320241994108, 27965.300867478476, 28693.13920582386, 28706.569401458994, 28715.712842871722, 2635.9472810543875, 2735.5623100304056, 2766.695663477016, 2770.6259654946525, 2861.856907154634, 422982.0, 426584.0, 429239.0, 429699.0, 431081.8445907782, 62405.0, 62623.0, 63045.0, 63471.0, 63512.68243658752, 66372.668136659, 66547.6690466188, 66623.6675266492, 66728.33271667318, 66754.99867501992, 17025.0, 17190.0, 17195.22621482011, 17195.914020429816, 17198.828011719972, 11862.822057669142, 12180.390980451119, 12968.35158242103, 13238.933805331104, 13349.132306400053, 18940.621187576173, 19038.904805476162, 19073.904630476758, 19087.236510539424, 19090.427287181406, 6792.811258029825, 7678.0, 7751.651175697107, 7964.681412743541, 8062.355011599058, 730.7985556658418, 1038.127972503101, 1055.6516349604613, 1085.5766251162054, 1090.2041509697806, 27938.16185514438, 28415.57376639352, 28613.71386286152, 28745.993890213744, 28765.56851647227, 1092.1754075672816, 1128.7347473343757, 1158.9478473468714, 1175.9412029398495, 1195.7429152732204, 14065.0, 14724.411023559152, 15023.849761502244, 15088.321025553876, 15451.84548154504, 619298.0, 875607.0, 921213.0, 924942.0, 927741.0, 62307.68846155831, 62561.37438625556, 63070.0, 63159.05261421082, 63173.684131579044, 1309.1621362328308, 1342.134323361446, 1462.6782107936237, 1478.9260536973109, 1485.6508720450686, 26429.0, 30812.383752325277, 31241.37517249688, 31385.215369615944, 32445.0, 54105.45894541004, 56901.0, 57807.421925781884, 58033.70983145057, 58273.417265828495, 570445.0, 574223.0, 575004.0, 575165.0, 578110.0, 24247.393815154763, 25182.244532664048, 27333.589996150473, 28253.72858221344, 28427.28931776722, 42279.0, 42617.78691106525, 43048.139037219706, 43161.60479940008, 43304.133917322106, 36211.0, 36820.0, 36823.815880920425, 37067.254575540836, 37529.0, 31075.68924310728, 36159.45760813537, 36261.09347266339, 36873.44689829709, 37011.44482832706, 35955.640443596276, 36562.26875462422, 36704.81647591745, 36725.26549469049, 37117.0, 31701.682983169874, 32062.35875282528, 32156.83921580377, 32304.0, 32304.35391292208, 22844.771552284263, 24052.39869003289, 24094.759052409954, 24512.877435612707, 24594.385140371633], "value": 20298.30422460498, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.7342293951583, 396.4133083037105, 397.46739369245205, 398.4640658314566, 410.83155906078497, 19211.13549890255, 19287.324943626976, 20224.898875505638, 20237.369142011536, 20238.494037649067, 19156.0, 20123.496912577193, 20331.898340508313, 20893.37319880406, 20894.582108357823, 5174.793008279665, 6065.423784740443, 6072.757089716406, 6079.118527813464, 6084.665343406111, 5724.370319264877, 5915.260592425947, 6012.518998480111, 6022.3074346450285, 6024.909626355608, 5819.9418005819825, 5981.0729336952845, 5992.49063829575, 5994.580379373446, 5997.250343707036, 5621.241132447109, 5976.3724808895095, 5978.461938425541, 5993.041113421875, 6015.969920150371, 5748.770049198027, 5758.452946970031, 5765.336986246593, 5766.279215098113, 5771.278590176228, 13630.182189068588, 13663.111897726616, 13746.381412836447, 13852.376643051088, 13868.86131138696, 2032.5833204193252, 2079.4281572567666, 2149.8172655324315, 2323.488832456857, 2584.2634849068113, 9819.901800982041, 10123.0, 10196.694099177037, 10289.691309260734, 10373.325733827278, 1663.4760050584027, 1742.4772568229607, 1777.6800175968322, 1784.7769028871392, 1804.6029873427824, 126429.0, 127412.0, 127860.0, 129235.0, 130558.3472082643, 11480.885191148149, 11690.649280521598, 11743.354115523729, 11757.647270581896, 11899.107566932342, 15417.691646167013, 15420.691586168214, 15445.22773861325, 15460.5361839145, 15464.690706185813, 8639.827203455896, 8693.261072808755, 8732.650693972297, 8747.650093996295, 8820.33847461443, 8521.786955326166, 8535.914640853636, 8536.274416674652, 8614.741557753277, 8649.091845356146, 4599.425071866017, 4628.282616194495, 4629.421322334708, 4639.628829693616, 4701.200795864711, 1803.1615298886081, 1901.990490047541, 1962.8822270663807, 1964.224131468062, 1966.3117908731829, 892.7098692924825, 910.740438974889, 932.8367535681228, 939.7415710679618, 959.7600599850037, 17227.0, 18082.395518318324, 19655.508612284808, 20224.089915953817, 20795.1681932721, 818.7502811642387, 928.6517555916531, 970.1801977329145, 973.2457345557108, 1002.7693630465034, 10595.046445819913, 10900.781984360268, 10943.179261555415, 10957.56169753201, 10958.890411095947, 585781.0, 601008.0, 616559.0, 617315.0, 624896.8755156195, 127177.0, 128536.71463285435, 128685.0, 129809.0, 132565.0, 1001.1440218613127, 1016.1210552871713, 1019.673704414595, 1039.428314427062, 1041.1982773264544, 18155.636887262444, 18287.0, 18414.35549755752, 18430.723539146657, 18433.354832580797, 40845.0, 46306.842328942046, 48097.519024809306, 49932.500674992785, 51059.23411148761, 75428.0, 75654.48691026258, 75944.0, 76578.0, 78717.0, 7093.929060709327, 7988.360931125612, 8179.0594081681365, 8351.24838764514, 8617.48295102296, 10069.791625005046, 10892.673219803419, 11278.379689117177, 12934.223946563236, 13060.412281447168, 10973.23187376876, 10989.890101098887, 10990.505427255952, 11053.447327633425, 11340.546378144782, 10902.018818306391, 10933.070688991525, 11064.612738554111, 11110.055645270242, 11262.436878156223, 11073.335599864035, 11513.578274760652, 11611.709707257387, 11692.0061794745, 11700.590479333183, 7030.367266945999, 7590.696372145052, 7643.503172293783, 7644.273793989562, 7972.322352600094, 11288.49201785938, 11487.94256028748, 11590.478428470908, 11645.59240426581, 11675.0], "value": 9403.193889984066, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1394.2819447984284, 1568.215892053973, 1582.889197756157, 1823.3253696132424, 1949.580840119373, 7852.332551733102, 8176.305014073796, 8526.744197674072, 8853.690120845771, 8866.290696744261, 8174.877376839352, 8655.523946182957, 8673.219410253076, 8675.0, 8716.389852710297, 2136.102836808544, 2351.6472529120597, 2424.527217192648, 2431.1612493689736, 2461.5323088613195, 2455.508898220363, 2487.577111890983, 2487.9674934901996, 2489.191012920799, 2489.850608963468, 2397.736249012607, 2448.9142879999204, 2450.240425468102, 2450.375154335642, 2450.571150048743, 2046.5395286060666, 2118.6292398830296, 2433.549793288247, 2437.0130097310616, 2438.9878050609723, 2418.7460316666675, 2434.3670645632087, 2434.720007199177, 2440.9511809763885, 2441.7192022917416, 8542.14578542147, 8583.969923609144, 8621.267192288664, 8623.965124185139, 8626.568671566396, 5019.021290848286, 5321.148616221425, 5325.094733895208, 5363.249145119687, 5371.57027437804, 3374.932501349984, 3388.5594872666643, 3464.826758662082, 3469.774464659789, 3473.1838018065732, 997.4464172384323, 997.6258902911409, 1015.8679371681708, 1021.9642312519101, 1034.9430781307026, 10797.40614266215, 11381.0, 11400.885991140149, 11413.657590272305, 11428.657140285888, 3841.980790096032, 4464.1071785643, 4579.893249105382, 4671.182543054952, 4683.7423941682855, 8950.14973577509, 8973.685920992733, 8976.640934362684, 8985.640574376952, 8988.460692358349, 5218.608604354688, 5219.660722053054, 5230.660007099526, 5271.130263506555, 5333.306670132858, 4029.657479114308, 4356.586124318184, 4540.909181816345, 4920.237363208708, 4921.50784921505, 3729.1050147964293, 3772.679322257639, 3839.1361943563033, 3840.558335791364, 3911.5501717302873, 1053.062774131024, 1174.2895548193392, 1178.1458442629025, 1188.364225139546, 1192.0880526397314, 812.5896422306815, 881.6164968238709, 887.40100432208, 898.6046139698511, 921.8478950973148, 5472.890542189213, 5500.779968801203, 5761.942380576224, 5772.0, 5817.534597232211, 443.6982851660837, 450.12675409705065, 455.90426010537493, 456.6392549885553, 463.4207240948814, 3468.809215493172, 3508.754387192872, 3727.9068023299633, 3815.9696881841746, 3857.8649747259274, 10292.485375731183, 10626.681199564026, 10831.0, 10832.0, 10837.458127093614, 10223.846642300372, 10390.636327728493, 10770.78458430827, 10784.245102842726, 10818.404987725751, 7396.0, 8034.357251419872, 8159.877601835978, 8228.8354232915, 8232.135625759329, 4716.0, 5342.732863356739, 5549.361823390362, 5864.618799778001, 5924.903892779849, 9602.423854568748, 9864.408135511892, 9884.851727223953, 9896.802063958536, 10003.549840257061, 9553.47455889905, 10024.749381265527, 10033.799324013333, 10141.442220677933, 10168.542415591168, 6795.0, 7092.04257425241, 7176.497645164997, 7288.052553168054, 7543.3965282778345, 8235.464694794819, 8276.337892968428, 8317.419690258832, 8326.333893288402, 8369.121242269473, 7169.4981351304905, 7269.273072692688, 7318.743843965649, 7385.446091543048, 7447.143578488326, 6004.789832355847, 7219.494635375683, 7264.67308971087, 7273.781786546412, 7406.111266648037, 6692.6988285526295, 6769.898451523132, 6787.389134977876, 6794.252632210551, 6798.694058767466, 4718.646101542329, 4777.737224452689, 4868.294097355934, 4925.556699897026, 5048.343715317133, 4846.588040016638, 4874.488178741181, 4888.804447822189, 4939.110960027229, 5105.2086926526445], "value": 4401.443015724551, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.94331020416325, 318.7832274053644, 323.9692229238222, 329.3577523828535, 332.2839281348694, 5508.862278443036, 5889.469947704706, 5956.493698035667, 5980.342162362137, 5987.790427335044, 5607.271054762885, 5763.933672270622, 5855.76576936922, 5874.853128671785, 5881.941180588193, 3623.800690961996, 4023.3160362738404, 4129.525104612963, 4345.804438800245, 4383.232934236512, 3745.5505339359315, 4438.291257865712, 4468.932966005513, 4476.9776151119195, 4483.753393563369, 4353.564643535653, 4436.401085853417, 4436.822527098929, 4446.244138496463, 4458.843940462085, 4216.0, 4234.640055595278, 4442.600165985061, 4455.2871540553515, 4516.322551617251, 3854.9229015419533, 3866.7486613370324, 3872.244912242114, 3883.98058009711, 3887.4751908492276, 5716.8856622867725, 5735.397783232784, 5743.368229494752, 5748.45389687979, 5757.424257574251, 4636.884077898046, 4958.652894297401, 5054.632673003478, 5201.687898726089, 5213.139831927728, 5559.19391688207, 6232.626042437469, 6249.937500624981, 6253.937460625381, 6286.371362863722, 3663.56037275526, 4313.741175529478, 4316.136772645452, 4328.870133895988, 4331.133773245332, 6172.259328880518, 6206.72069756862, 6382.425581697669, 6478.967605161991, 6624.470042396597, 4205.581790470492, 4240.809163587646, 4242.44848169736, 4254.31930891056, 4258.446401967786, 4042.2521833460905, 4171.478565179353, 4322.783860806947, 4339.828246373461, 4351.042770590465, 4268.0, 4373.300271956536, 4583.770811459481, 5076.756194732314, 5084.694918304914, 5316.362036555638, 5798.9130163047585, 6284.937150628435, 6296.65368404733, 6343.333949935282, 1466.3254902744643, 1481.3556103094973, 1482.8072350594568, 1483.6439254578822, 1491.686745783376, 874.5758307220992, 928.7074571509953, 957.1433566957534, 965.8647789309503, 971.621067783565, 5020.347354843847, 5065.0, 5802.709864506758, 5825.776586916795, 5886.911696324559, 5378.843548637062, 6004.979153543908, 6120.5823699638395, 6313.305536390993, 6462.127612772216, 4813.133635945494, 5209.739513024334, 5590.329160500766, 5694.743736531866, 5876.971529982236, 2887.4080813433197, 3395.388830010622, 3411.1301618087723, 3427.9314413711586, 3447.207142357272, 6249.625022498664, 6460.612363258219, 6774.695138718769, 6814.386705196457, 6836.760713375008, 5319.840404787863, 5625.915611265835, 6576.473882089422, 6675.4325882300545, 6694.59832410057, 5434.2935418395355, 5903.734331955158, 6389.936100639027, 6772.627505487147, 6814.250432452525, 5120.4111527174855, 5624.043912534797, 5939.643621382731, 6477.0, 6512.837179070371, 6168.444839964424, 6297.842553936188, 6389.463480928593, 6421.046318693453, 6432.807015789534, 5705.115707065412, 6471.126397936407, 6703.765368212089, 6714.731410743516, 6877.965610171917, 4169.999200191993, 4234.597713217239, 4269.530351661253, 4269.978650106729, 4274.166537525152, 5012.821986833164, 6011.969940150271, 6286.497080233662, 6565.901511477236, 6624.648249871227, 5334.573234141182, 5637.182608521824, 6361.4274715274, 6372.36276372359, 6425.164728585254, 5616.943830561806, 5961.582689211714, 6171.814845554641, 6369.426751592194, 6394.296627371078, 5744.5978781486565, 6219.253689557282, 6221.0, 6258.405451482102, 6269.62382257066, 5673.943260567342, 6054.878902421839, 6361.268454127835, 6362.141110949962, 6403.135576697086, 5433.483819037185, 5515.448455154453, 5889.230892228891, 6157.230346206724, 6267.2792628848265], "value": 4520.920555073812, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [656.1732217406069, 671.392389887152, 684.3225207045027, 690.406250624463, 691.1982100763116, 13055.73888522229, 13372.264525451097, 13417.194968301908, 13514.864851351484, 13607.0, 12467.68830779231, 12724.427400766965, 12983.80524292134, 13136.802947955788, 13228.603141905758, 722.1154086244335, 741.5031928607846, 906.8277027364812, 907.8093600343935, 924.2144177449148, 909.1771946388496, 914.3279689428265, 916.1983264643437, 917.3945196170529, 917.5274733512247, 987.0179171724144, 995.5768798260747, 996.1532697207352, 996.2826764729383, 997.9151772099381, 762.2034973452727, 780.9492382995087, 783.4163548156603, 784.2549577901017, 980.9803803923917, 703.8205257659264, 731.3929438565978, 733.0214164090945, 733.296035805622, 734.6179986407092, 11381.918717721803, 12964.611061668165, 13035.934820325932, 13045.934770326088, 13048.934755326163, 11551.942240288829, 11830.585929492427, 11902.047836173086, 11927.82108268368, 12100.152989290753, 9199.448033118035, 9266.721998340061, 9293.163615274658, 9332.066793320682, 9583.520823958845, 3399.6940275375337, 3405.5062016007787, 3428.794272343667, 3494.2662040971427, 3505.8597656093725, 71606.283937161, 72538.63730681312, 73409.6329518349, 74947.62526187388, 78480.0, 8704.695335663222, 8845.292376609856, 8850.114988501098, 8874.86687699685, 9080.22818060459, 19695.50761230952, 19769.60460790776, 19793.40619781409, 19795.703064454046, 20077.899610501852, 6992.895106573405, 7035.226125126232, 7043.119610048744, 7059.5058345915295, 7237.89143162853, 3864.091938394475, 3930.469386632768, 3932.8820135395413, 3934.6065393460426, 3940.5862384449792, 3279.967200328014, 3379.172102834772, 3379.3579219948133, 3385.373705864423, 3392.728581713457, 608.7625825927892, 614.3886832601501, 617.7714245729109, 626.8119564130834, 637.8596708724166, 465.8812002939297, 529.9072662284085, 555.4834004375888, 580.7705956147382, 585.3473377184408, 7420.109586849505, 7693.846123077619, 7701.3068823806125, 7906.9209307906185, 7916.683332666744, 526.1397614899666, 578.5892016668129, 581.1602234770716, 591.8461200087922, 607.2561112636985, 3590.2460483298278, 3591.6767490925417, 3613.9277214455565, 3616.52985111939, 3810.5427348717776, 82455.58772206101, 88806.11193888108, 89570.55214723885, 91096.54451727698, 96006.0, 72077.0, 77575.0, 79685.80471292936, 80212.79680804793, 80214.0, 58998.23005309847, 64176.037359439644, 67639.0, 70113.0, 70333.29666703267, 7142.678579463833, 7557.093148822177, 7714.768556943301, 7796.0, 7900.595494865664, 42655.14689706251, 42983.355249671906, 44586.77706611446, 45326.32010519779, 45386.319205211286, 64631.0, 65760.0, 65790.35524111935, 66075.67848643096, 66648.0, 10308.845367319345, 10311.278210525192, 10447.582096716047, 10574.10120139766, 10654.57381704723, 10962.725931851768, 11417.543298267976, 11464.770704586028, 11568.826467602825, 12176.0867934907, 10383.117435018108, 10405.739856503647, 10519.21105917044, 10609.469526523488, 10636.946815265874, 9250.95374523123, 9426.340156189, 9553.665621703485, 9575.856362154713, 9917.553710083208, 10529.210309226686, 10642.148628109888, 10715.785684286426, 10925.617603383844, 10980.890191098306, 9172.587233574372, 9271.76820579491, 9435.52822358893, 9474.478903660365, 9642.035796420301, 7279.880965457912, 8738.169873861973, 8992.82014359696, 9002.50486223264, 9094.909050909671], "value": 6504.357819547777, "unit": "score"}], "name": "dromaeo_css", "value": 7201.599257178821, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 111.0, 111.0, 113.0, 114.0, 163.0, 169.0, 113.0, 113.0, 112.0], "value": 123.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 148.0, 145.0, 169.0, 120.0, 150.0, 145.0, 120.0, 172.0, 118.0], "value": 146.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 187.0, 185.0, 184.0, 183.0, 206.0, 182.0, 183.0, 186.0], "value": 186.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 87.0, 90.0, 55.0, 58.0, 56.0, 78.0, 84.0, 56.0], "value": 71.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 100.0, 136.0, 79.0, 77.0, 77.0, 125.0, 79.0, 76.0, 123.0], "value": 96.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 90.0, 133.0, 124.0, 89.0, 86.0, 90.0, 102.0, 89.0, 84.0], "value": 97.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 96.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 84.0, 86.0, 86.0, 85.0, 86.0, 83.0, 85.0, 86.0], "value": 85.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 59.0, 58.0, 58.0, 58.0, 58.0, 57.0, 76.0, 59.0, 57.0], "value": 59.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 70.0, 63.0, 72.0, 70.0, 66.0, 66.0, 68.0, 67.0, 67.0], "value": 67.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 82.0, 81.0, 81.0, 82.0, 75.0, 78.0, 82.0, 82.0], "value": 80.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 138.0, 137.0, 135.0, 140.0, 136.0, 138.0, 138.0, 176.0, 145.0], "value": 142.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 169.0, 169.0, 200.0, 166.0, 166.0, 169.0, 173.0, 169.0, 168.0], "value": 173.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 95.0, 94.0, 83.0, 67.0, 69.0, 69.0, 69.0, 66.0], "value": 75.0, "unit": "score"}], "name": "kraken", "value": 1499.0, "alertThreshold": 2.0}]} 17:35:02 INFO - Return code: 0 17:35:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:35:02 ERROR - # TBPL SUCCESS # 17:35:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:35:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:35:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:35:02 INFO - 2016-04-18 17:35:02.703 screenresolution[1684:9998] starting screenresolution argv=screenresolution get 17:35:02 INFO - 2016-04-18 17:35:02.706 screenresolution[1684:9998] Display 0: 1600x1200x32@60 17:35:02 INFO - 2016-04-18 17:35:02.711 screenresolution[1685:10001] starting screenresolution argv=screenresolution list 17:35:02 INFO - Available Modes on Display 0 17:35:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:35:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:35:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:35:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:35:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:35:02 INFO - Intel Iris: 17:35:02 INFO - Chipset Model: Intel Iris 17:35:02 INFO - Type: GPU 17:35:02 INFO - Bus: Built-In 17:35:02 INFO - VRAM (Dynamic, Max): 1536 MB 17:35:02 INFO - Vendor: Intel (0x8086) 17:35:02 INFO - Device ID: 0x0a2e 17:35:02 INFO - Revision ID: 0x0009 17:35:02 INFO - Displays: 17:35:02 INFO - Display: 17:35:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:35:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:35:02 INFO - Display Serial Number: 1600x1200 60 17:35:02 INFO - Main Display: Yes 17:35:02 INFO - Mirror: Off 17:35:02 INFO - Online: Yes 17:35:02 INFO - Rotation: Supported 17:35:02 INFO - Return code: 0 17:35:02 INFO - Running post-action listener: _resource_record_post_action 17:35:02 INFO - Running post-run listener: _resource_record_post_run 17:35:04 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 32722432; Write bytes: 695250944; Read time: 328; Write time: 2059 17:35:04 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 373395968; Write bytes: 366937600; Read time: 28080; Write time: 688 17:35:04 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 31747584; Write bytes: 297912832; Read time: 314; Write time: 1313 17:35:04 INFO - Running post-run listener: _upload_blobber_files 17:35:04 INFO - Blob upload gear active. 17:35:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:35:04 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:35:04 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:35:04 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:35:04 INFO - (blobuploader) - INFO - Open directory for files ... 17:35:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:35:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:35:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:35:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:35:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:35:05 INFO - (blobuploader) - INFO - Done attempting. 17:35:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:35:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:35:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:35:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:35:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:35:06 INFO - (blobuploader) - INFO - Done attempting. 17:35:06 INFO - (blobuploader) - INFO - Iteration through files over. 17:35:06 INFO - Return code: 0 17:35:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:35:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:35:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9127cfeb180e4737d47c6d840c4cd6e830b5474719670261ca25ff7897c037cdb65374600c34a7c54540e4b4d1c17f779ac122e48f5ccf3f6bcbe422bc0502ca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/da1a15ed9da02f37a8603978638b0456e562d44e0c35c1faf89fe5b237c02b1f715b75f041b45f218f9230d9b6b3e26ba8752568d8889c2c8e6a2b7659b90d47"} 17:35:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:35:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:35:06 INFO - Contents: 17:35:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9127cfeb180e4737d47c6d840c4cd6e830b5474719670261ca25ff7897c037cdb65374600c34a7c54540e4b4d1c17f779ac122e48f5ccf3f6bcbe422bc0502ca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/da1a15ed9da02f37a8603978638b0456e562d44e0c35c1faf89fe5b237c02b1f715b75f041b45f218f9230d9b6b3e26ba8752568d8889c2c8e6a2b7659b90d47"} 17:35:06 INFO - Running post-run listener: copy_logs_to_upload_dir 17:35:06 INFO - Copying logs to upload dir... 17:35:06 INFO - mkdir: /builds/slave/test/build/upload/logs 17:35:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.073955 ========= master_lag: -0.15 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-04-18 17:35:06.514106) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 17:35:06.521368) ========= 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.Wt0kMS9d70/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.uRIc258BA9/Listeners TMPDIR=/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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/Fx-Team/sha512/9127cfeb180e4737d47c6d840c4cd6e830b5474719670261ca25ff7897c037cdb65374600c34a7c54540e4b4d1c17f779ac122e48f5ccf3f6bcbe422bc0502ca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/da1a15ed9da02f37a8603978638b0456e562d44e0c35c1faf89fe5b237c02b1f715b75f041b45f218f9230d9b6b3e26ba8752568d8889c2c8e6a2b7659b90d47"} build_url:https://queue.taskcluster.net/v1/task/X5Myv5iTSrioPNtTH8zUxQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010998 build_url: 'https://queue.taskcluster.net/v1/task/X5Myv5iTSrioPNtTH8zUxQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9127cfeb180e4737d47c6d840c4cd6e830b5474719670261ca25ff7897c037cdb65374600c34a7c54540e4b4d1c17f779ac122e48f5ccf3f6bcbe422bc0502ca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/da1a15ed9da02f37a8603978638b0456e562d44e0c35c1faf89fe5b237c02b1f715b75f041b45f218f9230d9b6b3e26ba8752568d8889c2c8e6a2b7659b90d47"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 17:35:06.554849) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 17:35:06.555294) ========= 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.Wt0kMS9d70/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.uRIc258BA9/Listeners TMPDIR=/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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.004993 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 17:35:06.611063) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 17:35:06.611405) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 17:35:06.611889) ========= ========= Total master_lag: 4.32 =========