builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0196 starttime: 1460968400.98 results: success (0) buildid: 20160417235318 builduid: 84aa7150b17f4414a32dad35a1188e66 revision: 96046381bf0b32a868995824a5abc6c209496a3e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 01:33:20.981113) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 01:33:20.981806) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 01:33:20.982158) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 01:33:21.014371) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 01:33:21.014633) ========= 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.8h5PI8SdKw/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.GousUrOCrg/Listeners TMPDIR=/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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 01:33:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.07M=0.001s 2016-04-18 01:33:21 (9.07 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122172 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 01:33:21.153752) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 01:33:21.154040) ========= 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.8h5PI8SdKw/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.GousUrOCrg/Listeners TMPDIR=/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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.027269 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 01:33:21.202116) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-18 01:33:21.202429) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 96046381bf0b32a868995824a5abc6c209496a3e --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 96046381bf0b32a868995824a5abc6c209496a3e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8h5PI8SdKw/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.GousUrOCrg/Listeners TMPDIR=/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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 01:33:21,277 truncating revision to first 12 chars 2016-04-18 01:33:21,277 Setting DEBUG logging. 2016-04-18 01:33:21,277 attempt 1/10 2016-04-18 01:33:21,277 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/96046381bf0b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-18 01:33:22,260 unpacking tar archive at: fx-team-96046381bf0b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.228070 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-18 01:33:22.446702) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 01:33:22.446979) ========= script_repo_revision: 96046381bf0b32a868995824a5abc6c209496a3e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 01:33:22.447385) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 01:33:22.447682) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 01:33:22.460763) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2016-04-18 01:33:22.461045) ========= /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.8h5PI8SdKw/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.GousUrOCrg/Listeners TMPDIR=/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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 01:33:22 INFO - MultiFileLogger online at 20160418 01:33:22 in /builds/slave/test 01:33:22 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 01:33:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:33:22 INFO - {'append_to_log': False, 01:33:22 INFO - 'base_work_dir': '/builds/slave/test', 01:33:22 INFO - 'blob_upload_branch': 'Fx-Team', 01:33:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:33:22 INFO - 'branch': 'Fx-Team', 01:33:22 INFO - 'buildbot_json_path': 'buildprops.json', 01:33:22 INFO - 'config_files': ('talos/mac_config.py',), 01:33:22 INFO - 'default_actions': ('clobber', 01:33:22 INFO - 'read-buildbot-config', 01:33:22 INFO - 'download-and-extract', 01:33:22 INFO - 'populate-webroot', 01:33:22 INFO - 'create-virtualenv', 01:33:22 INFO - 'install', 01:33:22 INFO - 'run-tests'), 01:33:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:33:22 INFO - 'download_minidump_stackwalk': True, 01:33:22 INFO - 'download_symbols': 'ondemand', 01:33:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:33:22 INFO - 'tooltool.py': '/tools/tooltool.py', 01:33:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:33:22 INFO - '/tools/misc-python/virtualenv.py')}, 01:33:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:33:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:33:22 INFO - 'installer_path': 'installer.exe', 01:33:22 INFO - 'log_level': 'info', 01:33:22 INFO - 'log_name': 'talos', 01:33:22 INFO - 'log_to_console': True, 01:33:22 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:33:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:33:22 INFO - 'opt_config_files': (), 01:33:22 INFO - 'pip_index': False, 01:33:22 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:33:22 INFO - 'cmd': ('bash', 01:33:22 INFO - '-c', 01:33:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:33:22 INFO - 'enabled': True, 01:33:22 INFO - 'halt_on_failure': False, 01:33:22 INFO - 'name': 'check_screen_resolution'},), 01:33:22 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:33:22 INFO - 'cmd': ('bash', 01:33:22 INFO - '-c', 01:33:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:33:22 INFO - 'enabled': True, 01:33:22 INFO - 'halt_on_failure': False, 01:33:22 INFO - 'name': 'check_screen_resolution'},), 01:33:22 INFO - 'run_cmd_checks_enabled': True, 01:33:22 INFO - 'sps_profile': False, 01:33:22 INFO - 'sps_profile_interval': 0, 01:33:22 INFO - 'suite': 'dromaeojs', 01:33:22 INFO - 'system_bits': '32', 01:33:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:33:22 INFO - 'title': 't-yosemite-r7-0196', 01:33:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:33:22 INFO - 'use_talos_json': True, 01:33:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:33:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:33:22 INFO - 'work_dir': 'build'} 01:33:22 INFO - ##### 01:33:22 INFO - ##### Running clobber step. 01:33:22 INFO - ##### 01:33:22 INFO - Running pre-action listener: _resource_record_pre_action 01:33:22 INFO - Running main action method: clobber 01:33:22 INFO - rmtree: /builds/slave/test/build 01:33:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:33:24 INFO - Running post-action listener: _resource_record_post_action 01:33:24 INFO - ##### 01:33:24 INFO - ##### Running read-buildbot-config step. 01:33:24 INFO - ##### 01:33:24 INFO - Running pre-action listener: _resource_record_pre_action 01:33:24 INFO - Running main action method: read_buildbot_config 01:33:24 INFO - Using buildbot properties: 01:33:24 INFO - { 01:33:24 INFO - "project": "", 01:33:24 INFO - "product": "firefox", 01:33:24 INFO - "script_repo_revision": "production", 01:33:24 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 01:33:24 INFO - "repository": "", 01:33:24 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 01:33:24 INFO - "buildid": "20160417235318", 01:33:24 INFO - "pgo_build": "False", 01:33:24 INFO - "basedir": "/builds/slave/test", 01:33:24 INFO - "buildnumber": 671, 01:33:24 INFO - "slavename": "t-yosemite-r7-0196", 01:33:24 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 01:33:24 INFO - "platform": "yosemite_r7", 01:33:24 INFO - "scheduler": "tests-fx-team-macosx64-talos", 01:33:24 INFO - "branch": "fx-team", 01:33:24 INFO - "repo_path": "integration/fx-team", 01:33:24 INFO - "revision": "96046381bf0b32a868995824a5abc6c209496a3e", 01:33:24 INFO - "stage_platform": "macosx64", 01:33:24 INFO - "builduid": "84aa7150b17f4414a32dad35a1188e66", 01:33:24 INFO - "slavebuilddir": "test" 01:33:24 INFO - } 01:33:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/NeMjG6faS6mIUkKbUW5-rg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 01:33:24 INFO - Running post-action listener: _resource_record_post_action 01:33:24 INFO - ##### 01:33:24 INFO - ##### Running download-and-extract step. 01:33:24 INFO - ##### 01:33:24 INFO - Running pre-action listener: _resource_record_pre_action 01:33:24 INFO - Running main action method: download_and_extract 01:33:24 INFO - mkdir: /builds/slave/test/build/tests 01:33:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 01:33:24 INFO - https://queue.taskcluster.net/v1/task/NeMjG6faS6mIUkKbUW5-rg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 01:33:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NeMjG6faS6mIUkKbUW5-rg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 01:33:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NeMjG6faS6mIUkKbUW5-rg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 01:33:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NeMjG6faS6mIUkKbUW5-rg/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 01:33:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NeMjG6faS6mIUkKbUW5-rg/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 01:33:44 INFO - Downloaded 1199 bytes. 01:33:44 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 01:33:44 INFO - Using the following test package requirements: 01:33:44 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 01:33:44 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:33:44 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 01:33:44 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:33:44 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 01:33:44 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:33:44 INFO - u'jsshell-mac.zip'], 01:33:44 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:33:44 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 01:33:44 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 01:33:44 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:33:44 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 01:33:44 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:33:44 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 01:33:44 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:33:44 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 01:33:44 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:33:44 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 01:33:44 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 01:33: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')]} 01:33:44 INFO - https://queue.taskcluster.net/v1/task/NeMjG6faS6mIUkKbUW5-rg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:33:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NeMjG6faS6mIUkKbUW5-rg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 01:33:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NeMjG6faS6mIUkKbUW5-rg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 01:33:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NeMjG6faS6mIUkKbUW5-rg/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 01:33:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NeMjG6faS6mIUkKbUW5-rg/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 01:33:45 INFO - Downloaded 18032012 bytes. 01:33:45 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'] 01:33:45 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 01:33:49 INFO - Return code: 0 01:33:49 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 01:33:49 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')]} 01:33:49 INFO - https://queue.taskcluster.net/v1/task/NeMjG6faS6mIUkKbUW5-rg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:33:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NeMjG6faS6mIUkKbUW5-rg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 01:33:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NeMjG6faS6mIUkKbUW5-rg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 01:33:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NeMjG6faS6mIUkKbUW5-rg/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 01:33:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NeMjG6faS6mIUkKbUW5-rg/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 01:33:50 INFO - Downloaded 18032012 bytes. 01:33:50 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'] 01:33:50 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 01:33:54 INFO - Return code: 0 01:33:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 01:33:54 INFO - https://queue.taskcluster.net/v1/task/NeMjG6faS6mIUkKbUW5-rg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 01:33:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NeMjG6faS6mIUkKbUW5-rg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 01:33:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NeMjG6faS6mIUkKbUW5-rg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 01:33:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NeMjG6faS6mIUkKbUW5-rg/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 01:33:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NeMjG6faS6mIUkKbUW5-rg/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 01:33:55 INFO - Downloaded 10841076 bytes. 01:33:55 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'] 01:33:55 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 01:33:56 INFO - Return code: 0 01:33:56 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')]} 01:33:56 INFO - https://queue.taskcluster.net/v1/task/NeMjG6faS6mIUkKbUW5-rg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 01:33:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NeMjG6faS6mIUkKbUW5-rg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 01:33:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NeMjG6faS6mIUkKbUW5-rg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 01:33:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NeMjG6faS6mIUkKbUW5-rg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 01:33:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NeMjG6faS6mIUkKbUW5-rg/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 01:34:00 INFO - Downloaded 109842730 bytes. 01:34:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NeMjG6faS6mIUkKbUW5-rg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 01:34:00 INFO - mkdir: /builds/slave/test/properties 01:34:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:34:00 INFO - Writing to file /builds/slave/test/properties/build_url 01:34:00 INFO - Contents: 01:34:00 INFO - build_url:https://queue.taskcluster.net/v1/task/NeMjG6faS6mIUkKbUW5-rg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 01:34:01 INFO - Running post-action listener: _resource_record_post_action 01:34:01 INFO - Running post-action listener: set_extra_try_arguments 01:34:01 INFO - ##### 01:34:01 INFO - ##### Running populate-webroot step. 01:34:01 INFO - ##### 01:34:01 INFO - Running pre-action listener: _resource_record_pre_action 01:34:01 INFO - Running main action method: populate_webroot 01:34:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:34:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:34:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:34:01 INFO - '--tppagecycles', 01:34:01 INFO - '7'], 01:34:01 INFO - 'tests': ['tsvgm']}}, 01:34:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:34:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:34:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:34:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:34:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:34:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:34:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:34:01 INFO - 'talos_options': ['--disable-e10s'], 01:34:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:34:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:34:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:34:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:34:01 INFO - 'talos_options': ['--disable-e10s'], 01:34:01 INFO - 'tests': ['damp', 'tps']}, 01:34:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:34:01 INFO - 'tests': ['damp', 'tps']}, 01:34:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:34:01 INFO - 'tests': ['dromaeo_dom']}, 01:34:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:34:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:34:01 INFO - 'tests': ['a11yr', 01:34:01 INFO - 'ts_paint', 01:34:01 INFO - 'tpaint', 01:34:01 INFO - 'sessionrestore', 01:34:01 INFO - 'sessionrestore_no_auto_restore', 01:34:01 INFO - 'tabpaint']}, 01:34:01 INFO - 'other-e10s': {'tests': ['a11yr', 01:34:01 INFO - 'ts_paint', 01:34:01 INFO - 'tpaint', 01:34:01 INFO - 'sessionrestore', 01:34:01 INFO - 'sessionrestore_no_auto_restore', 01:34:01 INFO - 'tabpaint']}, 01:34:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:34:01 INFO - 'ts_paint', 01:34:01 INFO - 'tpaint', 01:34:01 INFO - 'sessionrestore', 01:34:01 INFO - 'sessionrestore_no_auto_restore', 01:34:01 INFO - 'tabpaint']}, 01:34:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:34:01 INFO - 'ts_paint', 01:34:01 INFO - 'tpaint', 01:34:01 INFO - 'sessionrestore', 01:34:01 INFO - 'sessionrestore_no_auto_restore', 01:34:01 INFO - 'tabpaint']}, 01:34:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:34:01 INFO - 'tests': ['a11yr', 01:34:01 INFO - 'ts_paint', 01:34:01 INFO - 'tpaint', 01:34:01 INFO - 'sessionrestore', 01:34:01 INFO - 'sessionrestore_no_auto_restore', 01:34:01 INFO - 'tabpaint']}, 01:34:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:34:01 INFO - 'tests': ['a11yr', 01:34:01 INFO - 'ts_paint', 01:34:01 INFO - 'tpaint', 01:34:01 INFO - 'sessionrestore', 01:34:01 INFO - 'sessionrestore_no_auto_restore', 01:34:01 INFO - 'tabpaint']}, 01:34:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:34:01 INFO - 'tests': ['tsvgx', 01:34:01 INFO - 'tsvgr_opacity', 01:34:01 INFO - 'tart', 01:34:01 INFO - 'tscrollx', 01:34:01 INFO - 'cart']}, 01:34:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:34:01 INFO - 'tsvgr_opacity', 01:34:01 INFO - 'tart', 01:34:01 INFO - 'tscrollx', 01:34:01 INFO - 'cart']}, 01:34:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:34:01 INFO - 'talos_options': ['--disable-e10s'], 01:34:01 INFO - 'tests': ['tp5o']}, 01:34:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:34:01 INFO - 'tests': ['tp5o']}, 01:34:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:34:01 INFO - 'talos_options': ['--disable-e10s', 01:34:01 INFO - '--xperf_path', 01:34:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:34:01 INFO - 'tests': ['tp5n']}, 01:34:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:34:01 INFO - 'talos_options': ['--xperf_path', 01:34:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:34:01 INFO - 'tests': ['tp5n']}}, 01:34:01 INFO - 'talos.zip': {'path': '', 01:34:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:34:01 INFO - Running post-action listener: _resource_record_post_action 01:34:01 INFO - ##### 01:34:01 INFO - ##### Running create-virtualenv step. 01:34:01 INFO - ##### 01:34:01 INFO - Running pre-action listener: _resource_record_pre_action 01:34:01 INFO - Running main action method: create_virtualenv 01:34:01 INFO - Creating virtualenv /builds/slave/test/build/venv 01:34:01 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 01:34:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:34:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:34:01 INFO - Using real prefix '/tools/python27' 01:34:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:34:02 INFO - Installing distribute.............................................................................................................................................................................................done. 01:34:05 INFO - Installing pip.................done. 01:34:05 INFO - Return code: 0 01:34:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:34:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 01:34:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:34:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 01:34:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:34:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:05 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 0x104d9fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104daf420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f953957c820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c3ee00>, '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 0x104a67db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c39b20>, '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.8h5PI8SdKw/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.GousUrOCrg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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 01:34:05 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 01:34:05 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 01:34:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8h5PI8SdKw/Render', 01:34:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:34:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:34:05 INFO - 'HOME': '/Users/cltbld', 01:34:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:34:05 INFO - 'LOGNAME': 'cltbld', 01:34:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:05 INFO - 'MOZ_NO_REMOTE': '1', 01:34:05 INFO - 'NO_EM_RESTART': '1', 01:34:05 INFO - 'PAGER': '/bin/cat', 01:34:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:34:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:05 INFO - 'PWD': '/builds/slave/test', 01:34:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:34:05 INFO - 'SHELL': '/bin/bash', 01:34:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GousUrOCrg/Listeners', 01:34:05 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 01:34:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:34:05 INFO - 'USER': 'cltbld', 01:34:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:34:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:34:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:05 INFO - 'XPC_FLAGS': '0x0', 01:34:05 INFO - 'XPC_SERVICE_NAME': '0', 01:34:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:34:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:34:05 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 01:34:05 INFO - Cleaning up... 01:34:05 INFO - Return code: 0 01:34:05 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:34:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 01:34:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:34:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 01:34:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:34:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:05 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 0x104d9fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104daf420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f953957c820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c3ee00>, '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 0x104a67db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c39b20>, '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.8h5PI8SdKw/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.GousUrOCrg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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 01:34:05 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 01:34:05 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 01:34:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8h5PI8SdKw/Render', 01:34:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:34:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:34:05 INFO - 'HOME': '/Users/cltbld', 01:34:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:34:05 INFO - 'LOGNAME': 'cltbld', 01:34:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:05 INFO - 'MOZ_NO_REMOTE': '1', 01:34:05 INFO - 'NO_EM_RESTART': '1', 01:34:05 INFO - 'PAGER': '/bin/cat', 01:34:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:34:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:05 INFO - 'PWD': '/builds/slave/test', 01:34:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:34:05 INFO - 'SHELL': '/bin/bash', 01:34:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GousUrOCrg/Listeners', 01:34:05 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 01:34:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:34:05 INFO - 'USER': 'cltbld', 01:34:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:34:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:34:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:05 INFO - 'XPC_FLAGS': '0x0', 01:34:05 INFO - 'XPC_SERVICE_NAME': '0', 01:34:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:34:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:34:05 INFO - Downloading/unpacking psutil>=0.7.1 01:34:05 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 01:34:05 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 01:34:05 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 01:34:05 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 01:34:05 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 01:34:05 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 01:34:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:34:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:34:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:34:09 INFO - Installing collected packages: psutil 01:34:09 INFO - Running setup.py install for psutil 01:34:09 INFO - building 'psutil._psutil_osx' extension 01:34:09 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 01:34:10 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 01:34:10 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 01:34:10 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 01:34:10 INFO - building 'psutil._psutil_posix' extension 01:34:10 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 01:34:10 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:34:10 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:34:10 INFO - ^ 01:34:10 INFO - 1 warning generated. 01:34:10 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 01:34:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:34:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:34:10 INFO - Successfully installed psutil 01:34:10 INFO - Cleaning up... 01:34:10 INFO - Return code: 0 01:34:10 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:34:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 01:34:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:34:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 01:34:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:34:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104d9fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104daf420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f953957c820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c3ee00>, '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 0x104a67db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c39b20>, '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.8h5PI8SdKw/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.GousUrOCrg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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 01:34:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 01:34:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 01:34:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8h5PI8SdKw/Render', 01:34:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:34:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:34:10 INFO - 'HOME': '/Users/cltbld', 01:34:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:34:10 INFO - 'LOGNAME': 'cltbld', 01:34:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:10 INFO - 'MOZ_NO_REMOTE': '1', 01:34:10 INFO - 'NO_EM_RESTART': '1', 01:34:10 INFO - 'PAGER': '/bin/cat', 01:34:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:34:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:10 INFO - 'PWD': '/builds/slave/test', 01:34:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:34:10 INFO - 'SHELL': '/bin/bash', 01:34:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GousUrOCrg/Listeners', 01:34:10 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 01:34:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:34:10 INFO - 'USER': 'cltbld', 01:34:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:34:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:34:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:10 INFO - 'XPC_FLAGS': '0x0', 01:34:10 INFO - 'XPC_SERVICE_NAME': '0', 01:34:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:34:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:34:11 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:34:11 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 01:34:11 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 01:34:11 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 01:34:11 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 01:34:11 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 01:34:11 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 01:34:13 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:34:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:34:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:34:13 INFO - Installing collected packages: mozsystemmonitor 01:34:13 INFO - Running setup.py install for mozsystemmonitor 01:34:13 INFO - Successfully installed mozsystemmonitor 01:34:13 INFO - Cleaning up... 01:34:13 INFO - Return code: 0 01:34:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:34: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')]} 01:34:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:34:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34: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')]} 01:34:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:34:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104d9fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104daf420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f953957c820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c3ee00>, '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 0x104a67db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c39b20>, '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.8h5PI8SdKw/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.GousUrOCrg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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 01:34:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:34:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:34:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8h5PI8SdKw/Render', 01:34:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:34:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:34:13 INFO - 'HOME': '/Users/cltbld', 01:34:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:34:13 INFO - 'LOGNAME': 'cltbld', 01:34:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:13 INFO - 'MOZ_NO_REMOTE': '1', 01:34:13 INFO - 'NO_EM_RESTART': '1', 01:34:13 INFO - 'PAGER': '/bin/cat', 01:34:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:34:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:13 INFO - 'PWD': '/builds/slave/test', 01:34:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:34:13 INFO - 'SHELL': '/bin/bash', 01:34:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GousUrOCrg/Listeners', 01:34:13 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 01:34:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:34:13 INFO - 'USER': 'cltbld', 01:34:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:34:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:34:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:13 INFO - 'XPC_FLAGS': '0x0', 01:34:13 INFO - 'XPC_SERVICE_NAME': '0', 01:34:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:34:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:34:14 INFO - Downloading/unpacking blobuploader==1.2.4 01:34:14 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 01:34:14 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 01:34:14 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 01:34:14 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 01:34:14 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 01:34:14 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 01:34:16 INFO - Downloading blobuploader-1.2.4.tar.gz 01:34:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:34:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:34:16 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 01:34:16 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 01:34:16 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 01:34:16 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 01:34:16 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 01:34:16 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 01:34:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:34:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:34:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:34:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:34:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:34:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:34:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:34:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:34:17 INFO - Downloading docopt-0.6.1.tar.gz 01:34:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:34:17 INFO - Installing collected packages: blobuploader, requests, docopt 01:34:17 INFO - Running setup.py install for blobuploader 01:34:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:34:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:34:17 INFO - Running setup.py install for requests 01:34:18 INFO - Running setup.py install for docopt 01:34:18 INFO - Successfully installed blobuploader requests docopt 01:34:18 INFO - Cleaning up... 01:34:18 INFO - Return code: 0 01:34:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:34:18 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')]} 01:34:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:34:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:18 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')]} 01:34:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:34:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:18 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 0x104d9fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104daf420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f953957c820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c3ee00>, '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 0x104a67db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c39b20>, '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.8h5PI8SdKw/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.GousUrOCrg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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 01:34:18 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 01:34:18 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 01:34:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8h5PI8SdKw/Render', 01:34:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:34:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:34:18 INFO - 'HOME': '/Users/cltbld', 01:34:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:34:18 INFO - 'LOGNAME': 'cltbld', 01:34:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:18 INFO - 'MOZ_NO_REMOTE': '1', 01:34:18 INFO - 'NO_EM_RESTART': '1', 01:34:18 INFO - 'PAGER': '/bin/cat', 01:34:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:34:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:18 INFO - 'PWD': '/builds/slave/test', 01:34:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:34:18 INFO - 'SHELL': '/bin/bash', 01:34:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GousUrOCrg/Listeners', 01:34:18 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 01:34:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:34:18 INFO - 'USER': 'cltbld', 01:34:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:34:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:34:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:18 INFO - 'XPC_FLAGS': '0x0', 01:34:18 INFO - 'XPC_SERVICE_NAME': '0', 01:34:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:34:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:34:18 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-8Dbd3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:34:19 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-WgLJpR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:34:19 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-F2q2jI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:34:19 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-wN2pdo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:34:19 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-dOo6gI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:34:19 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-0ohrgn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:34:19 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-bTmpDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:34:19 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-T0Bb36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:34:19 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-DF1Bwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:34:19 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-QEGukK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:34:19 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-eSqHQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:34:20 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-ojtDhr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:34:20 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-Zmt9D5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:34:20 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-8PFGcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:34:20 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-BglixV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:34:20 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-BCqEM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:34:20 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-JzoLyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:34:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:34:20 INFO - Running setup.py install for manifestparser 01:34:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:34:20 INFO - Running setup.py install for mozcrash 01:34:21 INFO - Running setup.py install for mozdebug 01:34:21 INFO - Running setup.py install for mozdevice 01:34:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:34:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:34:21 INFO - Running setup.py install for mozfile 01:34:21 INFO - Running setup.py install for mozhttpd 01:34:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:34:21 INFO - Running setup.py install for mozinfo 01:34:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:34:21 INFO - Running setup.py install for mozInstall 01:34:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:34:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:34:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:34:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:34:21 INFO - Running setup.py install for mozleak 01:34:22 INFO - Running setup.py install for mozlog 01:34:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:34:22 INFO - Running setup.py install for moznetwork 01:34:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:34:22 INFO - Running setup.py install for mozprocess 01:34:22 INFO - Running setup.py install for mozprofile 01:34:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:34:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:34:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:34:22 INFO - Running setup.py install for mozrunner 01:34:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:34:22 INFO - Running setup.py install for mozscreenshot 01:34:23 INFO - Running setup.py install for moztest 01:34:23 INFO - Running setup.py install for mozversion 01:34:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:34:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:34:23 INFO - Cleaning up... 01:34:23 INFO - Return code: 0 01:34:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:34:23 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')]} 01:34:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:34:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:23 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')]} 01:34:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:34:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:23 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 0x104d9fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104daf420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f953957c820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c3ee00>, '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 0x104a67db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c39b20>, '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.8h5PI8SdKw/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.GousUrOCrg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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 01:34:23 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 01:34:23 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 01:34:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8h5PI8SdKw/Render', 01:34:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:34:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:34:23 INFO - 'HOME': '/Users/cltbld', 01:34:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:34:23 INFO - 'LOGNAME': 'cltbld', 01:34:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:23 INFO - 'MOZ_NO_REMOTE': '1', 01:34:23 INFO - 'NO_EM_RESTART': '1', 01:34:23 INFO - 'PAGER': '/bin/cat', 01:34:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:34:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:23 INFO - 'PWD': '/builds/slave/test', 01:34:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:34:23 INFO - 'SHELL': '/bin/bash', 01:34:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GousUrOCrg/Listeners', 01:34:23 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 01:34:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:34:23 INFO - 'USER': 'cltbld', 01:34:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:34:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:34:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:23 INFO - 'XPC_FLAGS': '0x0', 01:34:23 INFO - 'XPC_SERVICE_NAME': '0', 01:34:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:34:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:34:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:34:23 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-0tyhRP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:34:23 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)) 01:34:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:34:23 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-DpFGHW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:34:23 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)) 01:34:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:34:23 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-8cAwG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:34:23 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)) 01:34:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:34:23 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-7qwsLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:34:24 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)) 01:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:34:24 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-uVsZQ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:34:24 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)) 01:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:34:24 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-ASzZRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:34:24 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)) 01:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:34:24 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-V9pX2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:34:24 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)) 01:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:34:24 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-4JjUaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:34:24 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)) 01:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:34:24 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-9u_Ik4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:34:24 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)) 01:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:34:24 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-hHZQ7D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:34:24 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)) 01:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:34:24 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-00Vi3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:34:24 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)) 01:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:34:24 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-ZryJE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:34:24 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)) 01:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:34:24 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-6aS_kA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:34:24 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)) 01:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:34:24 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-m580F7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:34:25 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)) 01:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:34:25 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-clhf5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:34:25 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)) 01:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:34:25 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-I37SRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:34:25 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)) 01:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:34:25 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-ECMBae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:34:25 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)) 01:34:25 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)) 01:34:25 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)) 01:34:25 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)) 01:34:25 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)) 01:34:25 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)) 01:34:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:34:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:34:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:34:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:34:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:34:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:34:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:34:28 INFO - Downloading blessings-1.6.tar.gz 01:34:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:34:28 INFO - Installing collected packages: blessings 01:34:28 INFO - Running setup.py install for blessings 01:34:28 INFO - Successfully installed blessings 01:34:28 INFO - Cleaning up... 01:34:28 INFO - Return code: 0 01:34:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:34:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:34:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:34:28 INFO - Reading from file tmpfile_stdout 01:34:28 INFO - Current package versions: 01:34:28 INFO - blessings == 1.6 01:34:28 INFO - blobuploader == 1.2.4 01:34:28 INFO - docopt == 0.6.1 01:34:28 INFO - manifestparser == 1.1 01:34:28 INFO - mozInstall == 1.12 01:34:28 INFO - mozcrash == 0.17 01:34:28 INFO - mozdebug == 0.1 01:34:28 INFO - mozdevice == 0.48 01:34:28 INFO - mozfile == 1.2 01:34:28 INFO - mozhttpd == 0.7 01:34:28 INFO - mozinfo == 0.9 01:34:28 INFO - mozleak == 0.1 01:34:28 INFO - mozlog == 3.1 01:34:28 INFO - moznetwork == 0.27 01:34:28 INFO - mozprocess == 0.22 01:34:28 INFO - mozprofile == 0.28 01:34:28 INFO - mozrunner == 6.11 01:34:28 INFO - mozscreenshot == 0.1 01:34:28 INFO - mozsystemmonitor == 0.0 01:34:28 INFO - moztest == 0.7 01:34:28 INFO - mozversion == 1.4 01:34:28 INFO - psutil == 3.1.1 01:34:28 INFO - requests == 1.2.3 01:34:28 INFO - wsgiref == 0.1.2 01:34:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:34:28 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')]} 01:34:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:34:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:28 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')]} 01:34:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:34:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:28 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 0x104d9fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104daf420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f953957c820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c3ee00>, '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 0x104a67db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c39b20>, '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.8h5PI8SdKw/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.GousUrOCrg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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 01:34:28 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 01:34:28 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 01:34:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8h5PI8SdKw/Render', 01:34:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:34:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:34:28 INFO - 'HOME': '/Users/cltbld', 01:34:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:34:28 INFO - 'LOGNAME': 'cltbld', 01:34:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:28 INFO - 'MOZ_NO_REMOTE': '1', 01:34:28 INFO - 'NO_EM_RESTART': '1', 01:34:28 INFO - 'PAGER': '/bin/cat', 01:34:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:34:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:28 INFO - 'PWD': '/builds/slave/test', 01:34:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:34:28 INFO - 'SHELL': '/bin/bash', 01:34:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GousUrOCrg/Listeners', 01:34:28 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 01:34:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:34:28 INFO - 'USER': 'cltbld', 01:34:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:34:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:34:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:28 INFO - 'XPC_FLAGS': '0x0', 01:34:28 INFO - 'XPC_SERVICE_NAME': '0', 01:34:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:34:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:34:29 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)) 01:34:29 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)) 01:34:29 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)) 01:34:29 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)) 01:34:29 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)) 01:34:29 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)) 01:34:29 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)) 01:34:29 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)) 01:34:29 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)) 01:34:29 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)) 01:34:29 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)) 01:34:29 INFO - Cleaning up... 01:34:29 INFO - Return code: 0 01:34:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:34: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')]} 01:34:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:34:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34: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')]} 01:34:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:34:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104d9fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104daf420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f953957c820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c3ee00>, '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 0x104a67db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c39b20>, '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.8h5PI8SdKw/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.GousUrOCrg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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 01:34: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', 'jsonschema'] in /builds/slave/test/build 01:34: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 jsonschema 01:34:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8h5PI8SdKw/Render', 01:34:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:34:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:34:29 INFO - 'HOME': '/Users/cltbld', 01:34:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:34:29 INFO - 'LOGNAME': 'cltbld', 01:34:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:29 INFO - 'MOZ_NO_REMOTE': '1', 01:34:29 INFO - 'NO_EM_RESTART': '1', 01:34:29 INFO - 'PAGER': '/bin/cat', 01:34:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:34:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:29 INFO - 'PWD': '/builds/slave/test', 01:34:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:34:29 INFO - 'SHELL': '/bin/bash', 01:34:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GousUrOCrg/Listeners', 01:34:29 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 01:34:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:34:29 INFO - 'USER': 'cltbld', 01:34:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:34:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:34:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:29 INFO - 'XPC_FLAGS': '0x0', 01:34:29 INFO - 'XPC_SERVICE_NAME': '0', 01:34:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:34:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:34:29 INFO - Downloading/unpacking jsonschema 01:34:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:34:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:34:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:34:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:34:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:34:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:34:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:34:31 INFO - Downloading/unpacking functools32 (from jsonschema) 01:34:31 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 01:34:31 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 01:34:31 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 01:34:31 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 01:34:31 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 01:34:31 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 01:34:32 INFO - Downloading functools32-3.2.3-2.tar.gz 01:34:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:34:32 INFO - warning: no files found matching '*.txt' 01:34:32 INFO - no previously-included directories found matching 'build' 01:34:32 INFO - no previously-included directories found matching 'dist' 01:34:32 INFO - no previously-included directories found matching '.git*' 01:34:32 INFO - Installing collected packages: jsonschema, functools32 01:34:32 INFO - Running setup.py install for functools32 01:34:32 INFO - warning: no files found matching '*.txt' 01:34:32 INFO - no previously-included directories found matching 'build' 01:34:32 INFO - no previously-included directories found matching 'dist' 01:34:32 INFO - no previously-included directories found matching '.git*' 01:34:32 INFO - Successfully installed jsonschema functools32 01:34:32 INFO - Cleaning up... 01:34:32 INFO - Return code: 0 01:34:32 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:34:32 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')]} 01:34:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:34:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:32 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')]} 01:34:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:34:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:32 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 0x104d9fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104daf420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f953957c820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c3ee00>, '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 0x104a67db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c39b20>, '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.8h5PI8SdKw/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.GousUrOCrg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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 01:34:32 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 01:34:32 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 01:34:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8h5PI8SdKw/Render', 01:34:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:34:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:34:32 INFO - 'HOME': '/Users/cltbld', 01:34:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:34:32 INFO - 'LOGNAME': 'cltbld', 01:34:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:32 INFO - 'MOZ_NO_REMOTE': '1', 01:34:32 INFO - 'NO_EM_RESTART': '1', 01:34:32 INFO - 'PAGER': '/bin/cat', 01:34:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:34:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:32 INFO - 'PWD': '/builds/slave/test', 01:34:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:34:32 INFO - 'SHELL': '/bin/bash', 01:34:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GousUrOCrg/Listeners', 01:34:32 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 01:34:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:34:32 INFO - 'USER': 'cltbld', 01:34:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:34:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:34:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:32 INFO - 'XPC_FLAGS': '0x0', 01:34:32 INFO - 'XPC_SERVICE_NAME': '0', 01:34:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:34:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:34:32 INFO - Downloading/unpacking flake8 01:34: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 01:34: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 01:34: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 01:34: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 01:34: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 01:34: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 01:34:35 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:34:35 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:34:35 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 01:34:35 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 01:34:35 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 01:34:35 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 01:34:35 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 01:34:35 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 01:34:35 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:34:35 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:34:35 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 01:34:35 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 01:34:35 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 01:34:35 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 01:34:35 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 01:34:35 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 01:34:36 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:34:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:34:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:34:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:34:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:34:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:34:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:34:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:34:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:34:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:34:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:34:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:34:36 INFO - no previously-included directories found matching 'docs/_build' 01:34:36 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:34:36 INFO - Running setup.py install for pep8 01:34:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:34:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:34:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:34:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:34:36 INFO - no previously-included directories found matching 'docs/_build' 01:34:36 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:34:36 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:34:36 INFO - Cleaning up... 01:34:36 INFO - Return code: 0 01:34:36 INFO - Running post-action listener: _resource_record_post_action 01:34:36 INFO - Running post-action listener: _start_resource_monitoring 01:34:36 INFO - Starting resource monitoring. 01:34:36 INFO - ##### 01:34:36 INFO - ##### Running install step. 01:34:36 INFO - ##### 01:34:36 INFO - Running pre-action listener: _resource_record_pre_action 01:34:36 INFO - Running main action method: install 01:34:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:34:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:34:37 INFO - Reading from file tmpfile_stdout 01:34:37 INFO - Detecting whether we're running mozinstall >=1.0... 01:34:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:34:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:34:37 INFO - Reading from file tmpfile_stdout 01:34:37 INFO - Output received: 01:34:37 INFO - Usage: mozinstall [options] installer 01:34:37 INFO - Options: 01:34:37 INFO - -h, --help show this help message and exit 01:34:37 INFO - -d DEST, --destination=DEST 01:34:37 INFO - Directory to install application into. [default: 01:34:37 INFO - "/builds/slave/test"] 01:34:37 INFO - --app=APP Application being installed. [default: firefox] 01:34:37 INFO - mkdir: /builds/slave/test/build/application 01:34:37 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'] 01:34:37 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 01:35:11 INFO - Reading from file tmpfile_stdout 01:35:11 INFO - Output received: 01:35:11 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 01:35:11 INFO - Running post-action listener: _resource_record_post_action 01:35:11 INFO - ##### 01:35:11 INFO - ##### Running run-tests step. 01:35:11 INFO - ##### 01:35:11 INFO - Running pre-action listener: _resource_record_pre_action 01:35:11 INFO - Running main action method: run_tests 01:35:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:35:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:35:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:35:11 INFO - 2016-04-18 01:35:11.224 screenresolution[1644:7634] starting screenresolution argv=screenresolution get 01:35:11 INFO - 2016-04-18 01:35:11.227 screenresolution[1644:7634] Display 0: 1600x1200x32@60 01:35:11 INFO - 2016-04-18 01:35:11.233 screenresolution[1645:7636] starting screenresolution argv=screenresolution list 01:35:11 INFO - Available Modes on Display 0 01:35:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:35:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:35:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:35:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:35:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:35:11 INFO - Intel Iris: 01:35:11 INFO - Chipset Model: Intel Iris 01:35:11 INFO - Type: GPU 01:35:11 INFO - Bus: Built-In 01:35:11 INFO - VRAM (Dynamic, Max): 1536 MB 01:35:11 INFO - Vendor: Intel (0x8086) 01:35:11 INFO - Device ID: 0x0a2e 01:35:11 INFO - Revision ID: 0x0009 01:35:11 INFO - Displays: 01:35:11 INFO - Display: 01:35:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:35:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:35:11 INFO - Display Serial Number: 1600x1200 60 01:35:11 INFO - Main Display: Yes 01:35:11 INFO - Mirror: Off 01:35:11 INFO - Online: Yes 01:35:11 INFO - Rotation: Supported 01:35:11 INFO - Return code: 0 01:35:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:35:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:35:11 INFO - Python 2.7.3 01:35:11 INFO - Return code: 0 01:35:11 INFO - grabbing minidump binary from tooltool 01:35:11 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')]} 01:35:11 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 0x104c3ee00>, '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 0x104a67db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c39b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:35:11 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 01:35:11 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 01:35:11 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:35:11 INFO - Return code: 0 01:35:11 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:35:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:35:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:35:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:35:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:35:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:35:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:35:12 INFO - Return code: 0 01:35:12 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/NeMjG6faS6mIUkKbUW5-rg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0196', '--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 01:35:12 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/NeMjG6faS6mIUkKbUW5-rg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0196 --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 01:35:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8h5PI8SdKw/Render', 01:35:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:35:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:35:12 INFO - 'HOME': '/Users/cltbld', 01:35:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:35:12 INFO - 'LOGNAME': 'cltbld', 01:35:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:35:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:35:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:35:12 INFO - 'MOZ_NO_REMOTE': '1', 01:35:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:35:12 INFO - 'NO_EM_RESTART': '1', 01:35:12 INFO - 'PAGER': '/bin/cat', 01:35:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:35:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:35:12 INFO - 'PWD': '/builds/slave/test', 01:35:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:35:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:35:12 INFO - 'SHELL': '/bin/bash', 01:35:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GousUrOCrg/Listeners', 01:35:12 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 01:35:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:35:12 INFO - 'USER': 'cltbld', 01:35:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:35:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:35:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:35:12 INFO - 'XPC_FLAGS': '0x0', 01:35:12 INFO - 'XPC_SERVICE_NAME': '0', 01:35:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:35:12 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/NeMjG6faS6mIUkKbUW5-rg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0196', '--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 01:35:12 INFO - mozversion application_buildid: 20160417235318 01:35:12 INFO - mozversion application_changeset: 96046381bf0b32a868995824a5abc6c209496a3e 01:35:12 INFO - mozversion application_display_name: Nightly 01:35:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:35:12 INFO - mozversion application_name: Firefox 01:35:12 INFO - mozversion application_remotingname: firefox 01:35:12 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:35:12 INFO - mozversion application_vendor: Mozilla 01:35:12 INFO - mozversion application_version: 48.0a1 01:35:12 INFO - mozversion platform_buildid: 20160417235318 01:35:12 INFO - mozversion platform_changeset: 96046381bf0b32a868995824a5abc6c209496a3e 01:35:12 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:35:12 INFO - mozversion platform_version: 48.0a1 01:35:12 INFO - using testdate: 1460968512 01:35:12 INFO - actual date: 1460968512 01:35:12 INFO - starting webserver on 'localhost:49276' 01:35:12 INFO - SUITE-START | Running 2 tests 01:35:12 INFO - TEST-START | dromaeo_css 01:35:12 INFO - operating with platform_type : mac_ 01:35:12 INFO - Initialising browser for dromaeo_css test... 01:35:12 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/tmp7CGY2c/profile http://localhost:49276/getInfo.html) 01:35:15 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 01:35:15 INFO - PROCESS | 1663 | colorDepth:24 01:35:15 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 01:35:15 INFO - PROCESS | 1663 | __metrics 01:35:15 INFO - PROCESS | 1663 | 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" 01:35:15 ERROR - PROCESS | 1663 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:35:15 INFO - TEST-INFO | 1663: exit 0 01:35:15 INFO - Browser initialized. 01:35:15 INFO - Running cycle 1/1 for dromaeo_css test... 01:35:15 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/tmp7CGY2c/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:35:27 INFO - PROCESS | 1665 | RSS: Main: 237408256 01:35:27 INFO - PROCESS | 1665 | 01:36:19 INFO - PROCESS | 1665 | 1460968579343 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] 01:38:29 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 01:38:31 INFO - PROCESS | 1665 | RSS: Main: 375365632 01:38:31 INFO - PROCESS | 1665 | 01:41:34 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 01:41:34 INFO - PROCESS | 1665 | RSS: Main: 377397248 01:41:34 INFO - PROCESS | 1665 | 01:44:36 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 01:44:37 INFO - PROCESS | 1665 | RSS: Main: 375795712 01:44:37 INFO - PROCESS | 1665 | 01:47:39 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 01:47:40 INFO - PROCESS | 1665 | RSS: Main: 378408960 01:47:40 INFO - PROCESS | 1665 | 01:50:43 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 01:50:44 INFO - PROCESS | 1665 | RSS: Main: 349868032 01:50:44 INFO - PROCESS | 1665 | 01:53:46 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 01:53:46 INFO - PROCESS | 1665 | RSS: Main: 386523136 01:53:46 INFO - PROCESS | 1665 | 01:53:46 INFO - PROCESS | 1665 | __start_tp_report 01:53:46 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 01:53:46 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 01:53:46 INFO - PROCESS | 1665 | |i|pagename|runs| 01:53:46 INFO - PROCESS | 1665 | |0;dojo.html;2953.556966455032;3337.616174139974;3437.604675462321;3450.8964731058077;3488.8081155536433;5545.3622833374175;5616.5506759459295;5629.493345598895;5641.210230567724;5644.294463192101;4769.737664428464;5628.43715628437;5673;5695.345035320929;5787.363390027093;5081.949180508184;5120.257562653413;5121.155009423441;5146.022255771391;5333.493318134771;5234.398044224906;5255.816046438375;5261.394939581959;5288.418273989858;5304;5075.238714192864;5150.124478838607;5150.407703114152;5225.686458812484;5278.996990571779;5193.272941788153;5202.375714914235;5205.063088644042;5205.765740541685;5219.869503262411;5081.881985963082;5150.150225212836;5190.091733946544;5195.064888320101;5217;4235.3646952957;5525.254090697745;5535.944640553624;5552.7223638818305;5557.3331200255825;6144.815655530341;6193.194884665009;6196.814095577095;6210.937890621126;6218.31598524162;6184.381561843825;6228.252609686821;6229.750809967596;6238.968805155945;6255.311915689271;5588.524975377098;5588.804391846266;5709.058005429058;5721.4850663440075;5732.3407808101765;6249.781257656051;6274.843128921813;6284.842878928063;6295.905561416583;6298.559100862987;6029;6081.148639190517;6084.6349219047;6098.939010609926;6114.938850611437;6046.667433291123;6109.374301065143;6137.662428566382;6205.627662340274;6207.068939659087;6122.215193971364;6131.774283661951;6166;6166.537509686702;6180.938190618126;5154.484551544891;6172.22847144107;6176.4441200292185;6179.227596550431;6201.069839524108;3934.803259837054;4801.7118972861745;4818.277258411266;4867.634927380461;4869.366982292279;4376.299792033323;4415.867523974286;4446.444194475691;4452.732836029849;4455;5603.10350343943;5609.943900560942;5619.634723742944;5620.634658747168;5621.7189140542805;6116.579253789288;6133.018717005258;6151.446369826647;6163.7842675506145;6278.4035516625845;5629.54963602919;5630.577706672016;5640.041192997201;5641.887162256732;5667.234923285304;5298.311219541435;5299.44355842631;5301.496357845998;5307.761150748149;5364.9731751341;6158.507319414436;6176.536759743038;6228.159198508234;6257.217847769029;6305.5901366411035;6218.751249950133;6236.906446403398;6244.188255526752;6269.373062693694;6279.654618995999;6240.843978900564;6245.125682404376;6250.406211409909;6261.499080073674;6299.779507717208;6011.068284415923;6104.359042300494;6106.15732346443;6178.907316390348;6192.287886892885;6223.066540018853;6227.564070515021;6252.3122456530655;6252.812415627538;6253.093301471352;4841.346418233494;6045.395460453919;6056.7274472649715;6061.605995610271;6083.878322433615;5743.1385292206505;5800.984827655059;5819.127130930395;5834.445727655866;5862.267216597926;5860.413958604106;5861.238039054895;5875.41245875409;5881.176635271151;5903.203067585821;5812.447817457335;5859.5019423347785;5887.411258874078;6046.9697651513225;6089.665068421279;5778.248827652378;5778.971105144616;5805.564582656402;5812.244408227072;5826.388229235869 01:53:46 INFO - PROCESS | 1665 | |1;ext.html;497.73868718922563;508.55247382303577;509.9515546023129;526.6997811247588;560.5235549782683;29128.854355728217;29556.85221573892;37217.069573260684;37935.430968535424;38778.61221387785;40683.38974915371;41269.79365103178;41335.58664413355;41335.79332103335;41400;9446.197073248783;9701.563429645683;9705.805883882318;9708.61165553377;9710.90289097107;8527.104654011333;11564.190506664494;11899.226550274248;11907.642770716893;11949.223300485484;9845.753856153582;11514.42427878607;11630.185886987914;11642.6507204784;11651.708707282301;11456;11639.127065470038;11646.708832279177;11647.41762911851;11700.707482312926;10684.664416947882;10879.401632910187;11502.884971150348;11611.883881161164;11843.940780296129;39452.60547394547;39876.60123398758;39899.40150897739;39937;40031.59968400308;3218.871245150191;3291.4898190780227;3324.6010478742705;3452.7755695879687;3531.099569609759;29246;30696.693033069605;31272.21819454509;31375.529367059513;31417.8429107853;2626.474705058996;2693.5420978433517;2791.4138031013513;2820.732030457103;2823.0966090850934;394675;394857;397771;398905;399712;61913.38086619166;62459.68770156211;63052.05421918675;63064.05403918945;63284.683576581825;65823;65930.34069659242;66067.33932660708;66145.677086458;66264;16653.250603722863;17211.225494852762;17235.965842049518;17237.482875513753;17245.913770431067;11895.405229738652;12305.384730763426;13081.215127092404;13148;13155.53955611549;17096.230669619898;19444.80555194458;19486.06210832457;19690.40928772139;20242.493937651383;7790.454668173287;8019.39854510914;8023.879641805378;8048.114707382183;8143.556932920219;943.7499062748377;977.3402953006693;1007.1590222164575;1018.7453136715822;1065.227709910309;29409.823607055478;29736.405271894873;29755;29845.701542984727;29924.850375748418;1086.9673909782562;1091.7052395853234;1097.8572785537829;1147.2428197389684;1226.466487078106;12977;15204.391824327124;15491.457798976982;15682.215889205494;16018.839811601967;589302;620648;625563;628909;634686;59410;59472.40527594669;59536.80926381448;60208.69895650494;60418.79162416727;1218.4882349413444;1322.3850909327016;1371.854501491246;1476.0553245922617;1490.046370322994;28720;29072.12783616495;29325.706742932296;29970.850145750002;29990.70009299879;49092.772680683265;49520.50479495159;49574.25638615496;49690.254646179616;49879.750601246764;396925;401333;401519;401881;402613;22151.23429017039;22503.437414064778;23690.644640330753;26562.734372656025;26871.462570748085;41969.95075123147;42314;42399.36400953926;43783;43802.78098609487;32803.835980819946;33753.32493350168;33861.492077618364;34085.488717668755;34582.82708586441;36066.63933360633;36088.81955590205;36472;36878.26243475169;37015.074623134635;36836;37124.6287537132;37371.62628373681;37951.62048379481;38659;29222;31172.844135779174;31173.220669483446;32348.676513234568;32416.027519174462;24323.75676243286;24346;24472.510549789262;24505.632415514137;24704 01:53:46 INFO - PROCESS | 1665 | |2;jquery.html;355.7349774418058;396.5301118174963;399.8980260033692;405.61061381074165;408.7976451656431;14478.13131212128;18019.189136488858;19308.710369344455;20009.699854502174;20038.59922801545;15604.06375617461;18112.094395280248;19341.129649165785;19650.901745491254;20114.59770804583;5802.738876750545;5957.314908785502;6001.549883758714;6005.459508644221;6016.217891674076;5412.729363531827;5782.681952492632;5893.793717219898;6016.007358785795;6033.064874944391;5730.885382292373;5745.856353591152;5760.7695692172265;5788.160716696077;5792.71036448178;6325.557210995232;6583.901241481333;6588.858620948211;6595.043718660815;6596.868062638744;5562.805301814417;5813.593048486608;5813.912791308134;5833.2416785817995;5842.795502157404;13307.268100254481;13542.661433464144;13604.65988350299;14635.853641463556;25273.747262527508;2190.660447630604;2209.1826024370926;2337.637666161748;2462.384403899025;2775.653043369579;9413.90586094144;9934.9503252484;9970.102690757867;10058.698239052841;10153.847692284622;1727.3608764756996;1753.4038426934776;1764.2942822870825;1805.341050516552;1845.049799353334;103632.48183759108;106240;108701;110506.9999999992;110791.44604277008;11344.149188810872;11349.54601815918;11545.538178472934;11565.537378504934;11679.299242045505;14857.182854942866;14932.70134597302;14943.327550260046;14964.551063468114;14975.850241497663;5466.644668096561;7483.438742094365;8512.446690965067;8600.279944011223;8715.084916083846;6849.554778939353;6910.516263861582;6961;8459.027211870714;8594.5702714864;3752.2870654575545;4431.667624928079;4512.661550383735;4530.682852200314;4582.839600613963;1895.4503194073563;1957.9314723984592;1959.4121763470903;1964.7052942058806;1967.1344608372272;898;914.6981496106268;945.2910317262053;996.2030375699411;1051.2273478992934;19289.228430862888;20150.66852923574;20246.190152393738;20290.391288261377;20321.18715251403;949.5726922884729;949.6486300069018;965.4593427680521;999.5551979369111;1024.2062401638789;10396.48017599132;10564.788704225872;10580.89419105799;10589.417582032907;10606.522706478227;460308.39691603323;519770.4011479918;525974;526806;616716;122914.38542807408;129076;132274;141680;150105;451.41767120414954;479.9544043315949;1004.9497525123714;1053.052252972331;1053.2785042246087;10625.574977001143;10719.98160174782;11274.379909105079;11280.605178818701;11305.378204198849;35228.31514382124;37807.62192378041;50427.4871753848;50739.74630126826;52356.95286094333;48908.51091489182;62339;63243;63302;63722;5543.362513311021;7750.534967901944;7838.843223135391;7874.488158269694;8504.702335418231;11302.83045754298;12428.875711242772;12623.684407889876;13007.674808129872;13065.934670326587;10241.692749217535;10878.129749619853;10948.315413616376;11145.052670522771;11294.94352528232;11060.17048721333;11137.498812553617;11148.721281967692;11199.21605487608;11231.38227397501;10950.288231264942;11126.721831954266;11314.60398886035;11465.656030319104;11612.88387116118;8190.631421586162;8267.586620668822;8355.415120941476;8375.246227839523;8630.964284285676;11051.72370690739;11385.259958102697;11410.660814532836;11581.957623813898;11692.123090768397 01:53:46 INFO - PROCESS | 1665 | |3;mootools.html;1394.2680092951193;1571.9292631831565;1578.6921550297693;1820.4629634257901;1959.3240332085434;7154;7798.259165379287;8758.211760941515;8769.60536775845;8793.91206087939;8399.622017009235;8611.827763444728;8619.655213791457;8628.223459888608;8643.74068777936;2111.841611879115;2366.538524987628;2419.866907320092;2451.2156110044793;2459.987700061497;2464.544059349026;2474.492728990562;2484.6397272395493;2486.0677246032737;2486.7761901428867;2378.0606660369144;2447.938801529967;2448.1309135256906;2451.61483761675;2451.82837201396;2126.107035045277;2355.9764402355927;2424.9757502424927;2434.294054724128;2445.400876785199;2424.599941009731;2445.9726914695693;2463.9260822175365;2465.8027357811334;2467.8149138814483;8429.789255268606;8568.528730919797;8590.1839325264;8591.5704214789;8594.828103437958;4207.326827707583;5344.812931547416;5358.223057656618;5383.488568585978;5387.326584176978;3368.8820891268933;3387.915302117442;3459.7924124552605;3561;3571.053670777246;1000.6497725795986;1022.2844009193594;1023.0434543701663;1030.7320096774818;1031.7833255016455;11200.887991120066;11278.154138439568;11285.097192224684;11288.435578221057;11303.095752339794;4463.308187230984;4464.464264288306;4675.836345727951;4680.297955306732;4682.41469816273;9029.819403612022;9064.50145242018;9090.318226133066;9095.863562046574;9097.954510227406;5262.105442074857;5273.499017593323;5280.392754833167;5282.260483532308;5288.471152884757;3985.5416627087675;4387.758673273001;4533.274676051816;4552.908941821145;4877.073356062337;3789.981050094787;3863.439801228806;3896.7272290939363;3916.823742931575;3933.645971862546;1066.8318191580208;1186.211169572242;1192.8926396624345;1209.2200530657854;1217.4947396830394;791.76247125862;863.4258218284896;875.1511034296722;904.1952662130577;944.1266828183902;4945.653804233669;5669.31968163823;5702.771889124471;5910.970445147833;5989.439200610316;928.2249321816224;956.7034219392011;972.5283237629744;980.8577756225308;982.2436723722693;3349.2966477040095;3712.7957962311793;3753.680937120321;3868.25928332246;3895.7857317847793;10362.533685984148;10809.459527023617;10902.618408355669;10925.508352124174;10937.83593246102;10447.791044179074;10568.313059651251;10864.185186111074;10873.401962892116;10914.345139291669;8126.918730812617;8153.429259951865;8271.917280827114;8296.460730052406;8313.293370063491;5362.597805164551;5553.611247212656;5581.441855814386;5648.604597678123;5707.086866101404;9864.753381165528;9883.258755593215;9916.454594997056;9975.301728878909;9978.351407158512;8892.822143557221;9292.39599426035;9803.803923921625;9958.55186516594;10059.39643621385;5765;7379.151397589346;7379.8155046124275;7381.889271661037;7390;7975.641096150571;8148.348132149295;8154.959225203836;8156.673733050611;8160.143184965493;7179.246179151114;7275.454340924346;7445.4043676506835;7483;7505.549667019996;7145.499815013107;7230.504157614677;7249.347558719741;7325.047743793273;7357.411407087528;6816.284290149463;6927.168739751262;6928.515003949675;6934.4452443805385;6951.27011663768;4549.0901819636865;4670.602998745145;4700.412448443944;4766.1420944228985;4904.313396124617;4772.331873537777;4777.737224452689;4777.761111944458;4832.299316599144;4873.926891096708 01:53:46 INFO - PROCESS | 1665 | |4;prototype.html;315.21668653396307;319.9520071989202;326.3912802623108;331.9137024373662;334.3396791337111;5653.802116925908;5785.466851284407;5937;6000.579959402844;6024.849378765533;5583.58123140764;5775.27809023872;5808.1287806829;5826.9708651456685;5910.940890591093;4252.808623611945;4399.734136919489;4403.647708183354;4416.447944006999;4496.460424749034;4439.8446054388105;4451.1765323415275;4481.865544033668;4483.529229430912;4497.3029180476915;3428.4514477683574;4005.5794141615147;4250.468691413574;4308.6858508155;4454.933176002362;4010.7794071326066;4207.936880946758;4304.504981927087;4450.554944505556;4466.307722303049;3879.922401551953;3891.6886649068006;3909.6676782473523;3909.7488803582864;3947.5460322063045;4864.9053962858425;5650.7174641267775;5658.236138121342;5675.120356344773;5714.371419143891;4343.587359200871;4528.682992190548;4948.257761335793;5058.342415485963;5153.330067091291;5537.307836520435;6206.534509911729;6259.71831267594;6260.968695156495;6316.968415157895;4245.490541135053;4274.935875961863;4277.059047009653;4280.058387154852;4296.398504209413;5533.711373685386;5980.820575382745;6296.779612713533;6542.901856472156;6592.208934927791;3884.4950156479476;4246.681498887596;4333.414988976511;4346.239408103569;4361.9127617447475;3981.6416522513114;4052.6150015749045;4227.773945555754;4245.490541135084;4446.199684056836;4319.956800431955;4883.975580122076;5123.641345105882;5124.410692770304;5186.86194852109;6252.374762523802;6272;6278.4035516625845;6309.62142271456;6313.210848643919;1153.8038533449335;1294.9741005179844;1476.5496523560203;1479.1716638682158;1514.9621259468602;917.8347897378536;995.1690338567232;997.4613708597421;1010.2877471382658;1025.466757286222;5294.8941021180135;5797.565182611321;5810.854728631818;5815.389384114692;5816.156657284755;5724.82641058582;6120.112583675431;6426.2931077581425;6440.516961227927;6443.548951573439;5510.701652710892;5696.629719068247;5771.509421699203;5779.133130030529;5815.185873977646;3381.18851475649;3423.9657603424143;3428.794272343667;3430.776999495025;3435;5370.812021579304;6799.082123913307;6816.420604248595;6855.520113592101;6916.308369163044;5080.796768129308;5979.611325263844;6056.3338032816355;6627;6690.464762818963;5978.790742323998;6190.7523699052435;6466.224053113657;6783.966080169567;6784.6946887389195;5432.972835135799;6099.878002440015;6518.73925042993;6532.379423954717;6552;6159.965222779087;6423.903641445476;6445.5165862561435;6457.644829534421;6461.483081353386;5678.9617554608085;6000.339962604197;6009.549283803644;6233.480726473271;6863.588184708933;4109.568495308069;4200.096979149375;4235.639970602533;4248.426462427533;4253.255680255881;6149.96925015372;6506.251781045051;6515.383961901191;6547.672616369067;6567.408933196035;5778.983606393516;6129.509639228761;6237.345078766845;6313.463355614824;6332.905006424815;5482.684155802658;6135.601185922901;6217.564770466024;6316.589421687576;6318.368163183829;5211.863136114175;5782.814523022855;6167.229096362955;6193.783217587363;6199.535034872493;5800.274965629296;6272.560920735687;6300.495960323072;6322.494200464043;6348.809535713936;5162;5381.044931975073;6016.338202797776;6131.478824299985;6201.875962480815 01:53:46 INFO - PROCESS | 1665 | |5;yui.html;651.703474918912;727.9526830755997;756.5838788666232;758.1470845299037;791.2206476620531;14777.926110369446;15134.318955646995;15134.848651513481;15141.772873406908;15248.542543723692;13945.442182312696;14002.369893354798;14012;14029.36867840947;15281.006734562246;935.7707361696393;941.2752180820764;945.1021529546923;947.0860619502179;947.7346343023964;909.3997961345514;915.7847905742145;916.4318122763896;917.2341095185528;920.9585568649427;976.8681228034195;977.7604486900719;979.0796651147933;981.3326937682373;981.470006196653;966.859805328227;969.9418034917927;973.7711637765191;973.9513024348754;974.7124598243499;724.8586525627504;724.8803947348681;725.5791640848296;726.2700985509529;729.4456213277894;12841.29372884491;15201.163935983517;15238.695226095417;15264.771028434583;15272.31274592646;12122;12165.695857603541;12336.444859981322;12452.128351015432;12941;9846.458444785534;10068.647597334131;10179.18566514677;10381.273310868242;10474.319169253975;3428.245785927092;3451.32699123671;3499.737519686034;3654.104744337628;3708.4808126862263;77184;77475.61262193709;78468.82296765553;80016;80093.79859302116;7804;9152.633894644272;9204.815903681889;9225.261979041661;9427.670031548863;19836;20695.58608827815;20735.8963205183;20741.27405540829;20768.896155519127;7472.962635186898;7477.289657482531;7479.401647868158;7551.546907185587;7629;3855.5566109897723;3944.1717239379477;3971.1660551283976;3998.9600103998587;4167.624913757776;3521.2605352876185;3642.617525159873;3645.799481028516;3648.0150359402815;3649.197176621139;624.2477814233837;647.8801421736899;648.2933602373436;670.852412469256;675.2403546010738;568.6377460546998;569.1604882797923;574.7844558290641;605.2343785111836;605.4006533531772;6933.1333583302085;6983;7041.971952060663;7455.925440745632;7975.082865470429;568.2300482845767;573.8249833800647;590.3030123251788;598.3149294058279;604.727872457396;3574.517440145547;3593.94609080864;3607.7654952428534;3678.8528458861883;3808.9238215236096;87498.56250718706;88929.77675558033;89807;90449.54775226081;90669.09330906738;56103;70823;71724.99999999895;71937.28062719306;74322.62838685772;60017;65774.34225657683;66217;66377.66811165914;67970.98043529352;7070.7525236616475;7218.061651985418;7255.419566434567;7486.288802563748;7544.773656790305;34451.65548344485;42029.579704202566;42524.78737606292;43378.56621433745;44475;52398.73800630972;60468.39531604804;60954;61035;61055;8283.668653254044;8287.378446616407;8346.707865224687;8355.95822020886;8358.247757701836;10582.312149710553;10602.363858168535;10767.892321077003;11053.613123540637;11563.6530904073;8217.589120544068;9791.559379827782;9896.851547226654;9912.15746661513;10201;9944.45305508204;10002.649907253211;10036.548355323883;10129.240306976859;10354;9513;9544.475053872104;9562.426254424758;9672.661456848977;9899.802003960025;8429.4942303462;8517.95741021291;8525.232729054414;8585.098564650621;8736.91263087361;8132.878006829784;8255;8413.07456179832;8432.53621050848;8610.870836937325 01:53:46 INFO - PROCESS | 1665 | __end_tp_report 01:53:46 INFO - PROCESS | 1665 | __start_cc_report 01:53:46 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,1303 01:53:46 INFO - PROCESS | 1665 | __end_cc_report 01:53:46 INFO - PROCESS | 1665 | __startTimestamp1460969626960__endTimestamp 01:53:46 INFO - PROCESS | 1665 | 01:53:46 INFO - PROCESS | 1665 | ------- Summary: start ------- 01:53:46 INFO - PROCESS | 1665 | Number of tests: 6 01:53:46 INFO - PROCESS | 1665 | 01:53:46 INFO - PROCESS | 1665 | [#0] dojo.html Cycles:165 Average:5654.81 Median:5812.24 stddev:656.18 (11.3%) stddev-sans-first:623.03 01:53:46 INFO - PROCESS | 1665 | Values: 2953.6 3337.6 3437.6 3450.9 3488.8 5545.4 5616.6 5629.5 5641.2 5644.3 4769.7 5628.4 5673.0 5695.3 5787.4 5081.9 5120.3 5121.2 5146.0 5333.5 5234.4 5255.8 5261.4 5288.4 5304.0 5075.2 5150.1 5150.4 5225.7 5279.0 5193.3 5202.4 5205.1 5205.8 5219.9 5081.9 5150.2 5190.1 5195.1 5217.0 4235.4 5525.3 5535.9 5552.7 5557.3 6144.8 6193.2 6196.8 6210.9 6218.3 6184.4 6228.3 6229.8 6239.0 6255.3 5588.5 5588.8 5709.1 5721.5 5732.3 6249.8 6274.8 6284.8 6295.9 6298.6 6029.0 6081.1 6084.6 6098.9 6114.9 6046.7 6109.4 6137.7 6205.6 6207.1 6122.2 6131.8 6166.0 6166.5 6180.9 5154.5 6172.2 6176.4 6179.2 6201.1 3934.8 4801.7 4818.3 4867.6 4869.4 4376.3 4415.9 4446.4 4452.7 4455.0 5603.1 5609.9 5619.6 5620.6 5621.7 6116.6 6133.0 6151.4 6163.8 6278.4 5629.5 5630.6 5640.0 5641.9 5667.2 5298.3 5299.4 5301.5 5307.8 5365.0 6158.5 6176.5 6228.2 6257.2 6305.6 6218.8 6236.9 6244.2 6269.4 6279.7 6240.8 6245.1 6250.4 6261.5 6299.8 6011.1 6104.4 6106.2 6178.9 6192.3 6223.1 6227.6 6252.3 6252.8 6253.1 4841.3 6045.4 6056.7 6061.6 6083.9 5743.1 5801.0 5819.1 5834.4 5862.3 5860.4 5861.2 5875.4 5881.2 5903.2 5812.4 5859.5 5887.4 6047.0 6089.7 5778.2 5779.0 5805.6 5812.2 5826.4 01:53:46 INFO - PROCESS | 1665 | 01:53:46 INFO - PROCESS | 1665 | [#1] ext.html Cycles:180 Average:61934.75 Median:3308.05 stddev:129023.74 (3900.3%) stddev-sans-first:129303.23 01:53:46 INFO - PROCESS | 1665 | Values: 497.7 508.6 510.0 526.7 560.5 29128.9 29556.9 37217.1 37935.4 38778.6 40683.4 41269.8 41335.6 41335.8 41400.0 9446.2 9701.6 9705.8 9708.6 9710.9 8527.1 11564.2 11899.2 11907.6 11949.2 9845.8 11514.4 11630.2 11642.7 11651.7 11456.0 11639.1 11646.7 11647.4 11700.7 10684.7 10879.4 11502.9 11611.9 11843.9 39452.6 39876.6 39899.4 39937.0 40031.6 3218.9 3291.5 3324.6 3452.8 3531.1 29246.0 30696.7 31272.2 31375.5 31417.8 2626.5 2693.5 2791.4 2820.7 2823.1 394675.0 394857.0 397771.0 398905.0 399712.0 61913.4 62459.7 63052.1 63064.1 63284.7 65823.0 65930.3 66067.3 66145.7 66264.0 16653.3 17211.2 17236.0 17237.5 17245.9 11895.4 12305.4 13081.2 13148.0 13155.5 17096.2 19444.8 19486.1 19690.4 20242.5 7790.5 8019.4 8023.9 8048.1 8143.6 943.7 977.3 1007.2 1018.7 1065.2 29409.8 29736.4 29755.0 29845.7 29924.9 1087.0 1091.7 1097.9 1147.2 1226.5 12977.0 15204.4 15491.5 15682.2 16018.8 589302.0 620648.0 625563.0 628909.0 634686.0 59410.0 59472.4 59536.8 60208.7 60418.8 1218.5 1322.4 1371.9 1476.1 1490.0 28720.0 29072.1 29325.7 29970.9 29990.7 49092.8 49520.5 49574.3 49690.3 49879.8 396925.0 401333.0 401519.0 401881.0 402613.0 22151.2 22503.4 23690.6 26562.7 26871.5 41970.0 42314.0 42399.4 43783.0 43802.8 32803.8 33753.3 33861.5 34085.5 34582.8 36066.6 36088.8 36472.0 36878.3 37015.1 36836.0 37124.6 37371.6 37951.6 38659.0 29222.0 31172.8 31173.2 32348.7 32416.0 24323.8 24346.0 24472.5 24505.6 24704.0 01:53:46 INFO - PROCESS | 1665 | 01:53:46 INFO - PROCESS | 1665 | [#2] jquery.html Cycles:180 Average:31711.99 Median:11255.92 stddev:89395.66 (794.2%) stddev-sans-first:89615.43 01:53:46 INFO - PROCESS | 1665 | Values: 355.7 396.5 399.9 405.6 408.8 14478.1 18019.2 19308.7 20009.7 20038.6 15604.1 18112.1 19341.1 19650.9 20114.6 5802.7 5957.3 6001.5 6005.5 6016.2 5412.7 5782.7 5893.8 6016.0 6033.1 5730.9 5745.9 5760.8 5788.2 5792.7 6325.6 6583.9 6588.9 6595.0 6596.9 5562.8 5813.6 5813.9 5833.2 5842.8 13307.3 13542.7 13604.7 14635.9 25273.7 2190.7 2209.2 2337.6 2462.4 2775.7 9413.9 9935.0 9970.1 10058.7 10153.8 1727.4 1753.4 1764.3 1805.3 1845.0 103632.5 106240.0 108701.0 110507.0 110791.4 11344.1 11349.5 11545.5 11565.5 11679.3 14857.2 14932.7 14943.3 14964.6 14975.9 5466.6 7483.4 8512.4 8600.3 8715.1 6849.6 6910.5 6961.0 8459.0 8594.6 3752.3 4431.7 4512.7 4530.7 4582.8 1895.5 1957.9 1959.4 1964.7 1967.1 898.0 914.7 945.3 996.2 1051.2 19289.2 20150.7 20246.2 20290.4 20321.2 949.6 949.6 965.5 999.6 1024.2 10396.5 10564.8 10580.9 10589.4 10606.5 460308.4 519770.4 525974.0 526806.0 616716.0 122914.4 129076.0 132274.0 141680.0 150105.0 451.4 480.0 1004.9 1053.1 1053.3 10625.6 10720.0 11274.4 11280.6 11305.4 35228.3 37807.6 50427.5 50739.7 52357.0 48908.5 62339.0 63243.0 63302.0 63722.0 5543.4 7750.5 7838.8 7874.5 8504.7 11302.8 12428.9 12623.7 13007.7 13065.9 10241.7 10878.1 10948.3 11145.1 11294.9 11060.2 11137.5 11148.7 11199.2 11231.4 10950.3 11126.7 11314.6 11465.7 11612.9 8190.6 8267.6 8355.4 8375.2 8631.0 11051.7 11385.3 11410.7 11582.0 11692.1 01:53:46 INFO - PROCESS | 1665 | 01:53:46 INFO - PROCESS | 1665 | [#3] mootools.html Cycles:180 Average:5578.14 Median:4890.69 stddev:3114.51 (63.7%) stddev-sans-first:3107.37 01:53:46 INFO - PROCESS | 1665 | Values: 1394.3 1571.9 1578.7 1820.5 1959.3 7154.0 7798.3 8758.2 8769.6 8793.9 8399.6 8611.8 8619.7 8628.2 8643.7 2111.8 2366.5 2419.9 2451.2 2460.0 2464.5 2474.5 2484.6 2486.1 2486.8 2378.1 2447.9 2448.1 2451.6 2451.8 2126.1 2356.0 2425.0 2434.3 2445.4 2424.6 2446.0 2463.9 2465.8 2467.8 8429.8 8568.5 8590.2 8591.6 8594.8 4207.3 5344.8 5358.2 5383.5 5387.3 3368.9 3387.9 3459.8 3561.0 3571.1 1000.6 1022.3 1023.0 1030.7 1031.8 11200.9 11278.2 11285.1 11288.4 11303.1 4463.3 4464.5 4675.8 4680.3 4682.4 9029.8 9064.5 9090.3 9095.9 9098.0 5262.1 5273.5 5280.4 5282.3 5288.5 3985.5 4387.8 4533.3 4552.9 4877.1 3790.0 3863.4 3896.7 3916.8 3933.6 1066.8 1186.2 1192.9 1209.2 1217.5 791.8 863.4 875.2 904.2 944.1 4945.7 5669.3 5702.8 5911.0 5989.4 928.2 956.7 972.5 980.9 982.2 3349.3 3712.8 3753.7 3868.3 3895.8 10362.5 10809.5 10902.6 10925.5 10937.8 10447.8 10568.3 10864.2 10873.4 10914.3 8126.9 8153.4 8271.9 8296.5 8313.3 5362.6 5553.6 5581.4 5648.6 5707.1 9864.8 9883.3 9916.5 9975.3 9978.4 8892.8 9292.4 9803.8 9958.6 10059.4 5765.0 7379.2 7379.8 7381.9 7390.0 7975.6 8148.3 8155.0 8156.7 8160.1 7179.2 7275.5 7445.4 7483.0 7505.5 7145.5 7230.5 7249.3 7325.0 7357.4 6816.3 6927.2 6928.5 6934.4 6951.3 4549.1 4670.6 4700.4 4766.1 4904.3 4772.3 4777.7 4777.8 4832.3 4873.9 01:53:46 INFO - PROCESS | 1665 | 01:53:46 INFO - PROCESS | 1665 | [#4] prototype.html Cycles:180 Average:5049.76 Median:5705.50 stddev:1569.23 (27.5%) stddev-sans-first:1532.86 01:53:46 INFO - PROCESS | 1665 | Values: 315.2 320.0 326.4 331.9 334.3 5653.8 5785.5 5937.0 6000.6 6024.8 5583.6 5775.3 5808.1 5827.0 5910.9 4252.8 4399.7 4403.6 4416.4 4496.5 4439.8 4451.2 4481.9 4483.5 4497.3 3428.5 4005.6 4250.5 4308.7 4454.9 4010.8 4207.9 4304.5 4450.6 4466.3 3879.9 3891.7 3909.7 3909.7 3947.5 4864.9 5650.7 5658.2 5675.1 5714.4 4343.6 4528.7 4948.3 5058.3 5153.3 5537.3 6206.5 6259.7 6261.0 6317.0 4245.5 4274.9 4277.1 4280.1 4296.4 5533.7 5980.8 6296.8 6542.9 6592.2 3884.5 4246.7 4333.4 4346.2 4361.9 3981.6 4052.6 4227.8 4245.5 4446.2 4320.0 4884.0 5123.6 5124.4 5186.9 6252.4 6272.0 6278.4 6309.6 6313.2 1153.8 1295.0 1476.5 1479.2 1515.0 917.8 995.2 997.5 1010.3 1025.5 5294.9 5797.6 5810.9 5815.4 5816.2 5724.8 6120.1 6426.3 6440.5 6443.5 5510.7 5696.6 5771.5 5779.1 5815.2 3381.2 3424.0 3428.8 3430.8 3435.0 5370.8 6799.1 6816.4 6855.5 6916.3 5080.8 5979.6 6056.3 6627.0 6690.5 5978.8 6190.8 6466.2 6784.0 6784.7 5433.0 6099.9 6518.7 6532.4 6552.0 6160.0 6423.9 6445.5 6457.6 6461.5 5679.0 6000.3 6009.5 6233.5 6863.6 4109.6 4200.1 4235.6 4248.4 4253.3 6150.0 6506.3 6515.4 6547.7 6567.4 5779.0 6129.5 6237.3 6313.5 6332.9 5482.7 6135.6 6217.6 6316.6 6318.4 5211.9 5782.8 6167.2 6193.8 6199.5 5800.3 6272.6 6300.5 6322.5 6348.8 5162.0 5381.0 6016.3 6131.5 6201.9 01:53:46 INFO - PROCESS | 1665 | 01:53:46 INFO - PROCESS | 1665 | [#5] yui.html Cycles:180 Average:16907.52 Median:37452.06 stddev:23908.81 (63.8%) stddev-sans-first:23944.72 01:53:46 INFO - PROCESS | 1665 | Values: 651.7 728.0 756.6 758.1 791.2 14777.9 15134.3 15134.8 15141.8 15248.5 13945.4 14002.4 14012.0 14029.4 15281.0 935.8 941.3 945.1 947.1 947.7 909.4 915.8 916.4 917.2 921.0 976.9 977.8 979.1 981.3 981.5 966.9 969.9 973.8 974.0 974.7 724.9 724.9 725.6 726.3 729.4 12841.3 15201.2 15238.7 15264.8 15272.3 12122.0 12165.7 12336.4 12452.1 12941.0 9846.5 10068.6 10179.2 10381.3 10474.3 3428.2 3451.3 3499.7 3654.1 3708.5 77184.0 77475.6 78468.8 80016.0 80093.8 7804.0 9152.6 9204.8 9225.3 9427.7 19836.0 20695.6 20735.9 20741.3 20768.9 7473.0 7477.3 7479.4 7551.5 7629.0 3855.6 3944.2 3971.2 3999.0 4167.6 3521.3 3642.6 3645.8 3648.0 3649.2 624.2 647.9 648.3 670.9 675.2 568.6 569.2 574.8 605.2 605.4 6933.1 6983.0 7042.0 7455.9 7975.1 568.2 573.8 590.3 598.3 604.7 3574.5 3593.9 3607.8 3678.9 3808.9 87498.6 88929.8 89807.0 90449.5 90669.1 56103.0 70823.0 71725.0 71937.3 74322.6 60017.0 65774.3 66217.0 66377.7 67971.0 7070.8 7218.1 7255.4 7486.3 7544.8 34451.7 42029.6 42524.8 43378.6 44475.0 52398.7 60468.4 60954.0 61035.0 61055.0 8283.7 8287.4 8346.7 8356.0 8358.2 10582.3 10602.4 10767.9 11053.6 11563.7 8217.6 9791.6 9896.9 9912.2 10201.0 9944.5 10002.6 10036.5 10129.2 10354.0 9513.0 9544.5 9562.4 9672.7 9899.8 8429.5 8518.0 8525.2 8585.1 8736.9 8132.9 8255.0 8413.1 8432.5 8610.9 01:53:46 INFO - PROCESS | 1665 | -------- Summary: end -------- 01:53:46 INFO - PROCESS | 1665 | 01:53:47 INFO - TEST-INFO | 1665: exit 0 01:53:47 INFO - TEST-OK | dromaeo_css | took 1114524ms 01:53:47 INFO - TEST-START | kraken 01:53:47 INFO - operating with platform_type : mac_ 01:53:47 INFO - Initialising browser for kraken test... 01:53:47 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/tmpbK1K_X/profile http://localhost:49276/getInfo.html) 01:53:49 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 01:53:49 INFO - PROCESS | 1672 | colorDepth:24 01:53:49 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 01:53:49 INFO - PROCESS | 1672 | __metrics 01:53:49 INFO - PROCESS | 1672 | 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" 01:53:49 ERROR - PROCESS | 1672 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:53:50 INFO - TEST-INFO | 1672: exit 0 01:53:50 INFO - Browser initialized. 01:53:50 INFO - Running cycle 1/1 for kraken test... 01:53:50 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/tmpbK1K_X/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:54:02 INFO - PROCESS | 1674 | RSS: Main: 237375488 01:54:02 INFO - PROCESS | 1674 | 01:54:04 INFO - PROCESS | 1674 | 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) 01:54:05 INFO - PROCESS | 1674 | RSS: Main: 285757440 01:54:05 INFO - PROCESS | 1674 | 01:54:08 INFO - PROCESS | 1674 | 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) 01:54:09 INFO - PROCESS | 1674 | RSS: Main: 299204608 01:54:09 INFO - PROCESS | 1674 | 01:54:12 INFO - PROCESS | 1674 | 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) 01:54:13 INFO - PROCESS | 1674 | RSS: Main: 383954944 01:54:13 INFO - PROCESS | 1674 | 01:54:15 INFO - PROCESS | 1674 | 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) 01:54:15 INFO - PROCESS | 1674 | RSS: Main: 285691904 01:54:15 INFO - PROCESS | 1674 | 01:54:18 INFO - PROCESS | 1674 | 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) 01:54:18 INFO - PROCESS | 1674 | RSS: Main: 290299904 01:54:18 INFO - PROCESS | 1674 | 01:54:21 INFO - PROCESS | 1674 | 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) 01:54:21 INFO - PROCESS | 1674 | RSS: Main: 329007104 01:54:21 INFO - PROCESS | 1674 | 01:54:24 INFO - PROCESS | 1674 | 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) 01:54:25 INFO - PROCESS | 1674 | RSS: Main: 328097792 01:54:25 INFO - PROCESS | 1674 | 01:54:28 INFO - PROCESS | 1674 | 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) 01:54:28 INFO - PROCESS | 1674 | RSS: Main: 328577024 01:54:28 INFO - PROCESS | 1674 | 01:54:30 INFO - PROCESS | 1674 | 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) 01:54:30 INFO - PROCESS | 1674 | RSS: Main: 319795200 01:54:30 INFO - PROCESS | 1674 | 01:54:32 INFO - PROCESS | 1674 | 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) 01:54:33 INFO - PROCESS | 1674 | RSS: Main: 326082560 01:54:33 INFO - PROCESS | 1674 | 01:54:35 INFO - PROCESS | 1674 | 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) 01:54:36 INFO - PROCESS | 1674 | RSS: Main: 329482240 01:54:36 INFO - PROCESS | 1674 | 01:54:39 INFO - PROCESS | 1674 | 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) 01:54:39 INFO - PROCESS | 1674 | RSS: Main: 334467072 01:54:39 INFO - PROCESS | 1674 | 01:54:42 INFO - PROCESS | 1674 | 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) 01:54:43 INFO - PROCESS | 1674 | RSS: Main: 332009472 01:54:43 INFO - PROCESS | 1674 | 01:54:45 INFO - PROCESS | 1674 | 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) 01:54:45 INFO - PROCESS | 1674 | RSS: Main: 396218368 01:54:45 INFO - PROCESS | 1674 | 01:54:45 INFO - PROCESS | 1674 | __start_tp_report 01:54:45 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 01:54:45 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 01:54:45 INFO - PROCESS | 1674 | |i|pagename|runs| 01:54:45 INFO - PROCESS | 1674 | |0;ai-astar;111;109;112;113;112;112;116;112;113;112 01:54:45 INFO - PROCESS | 1674 | |1;audio-beat-detection;155;134;183;184;119;144;140;120;167;119 01:54:45 INFO - PROCESS | 1674 | |2;audio-dft;186;185;186;184;186;183;186;183;183;180 01:54:45 INFO - PROCESS | 1674 | |3;audio-fft;73;75;73;148;55;56;64;62;132;54 01:54:45 INFO - PROCESS | 1674 | |4;audio-oscillator;90;96;133;78;77;80;124;79;77;120 01:54:45 INFO - PROCESS | 1674 | |5;imaging-gaussian-blur;88;86;87;85;89;87;87;85;87;84 01:54:45 INFO - PROCESS | 1674 | |6;imaging-darkroom;94;93;93;94;92;92;93;93;92;93 01:54:45 INFO - PROCESS | 1674 | |7;imaging-desaturate;85;85;84;86;87;85;86;83;85;84 01:54:45 INFO - PROCESS | 1674 | |8;json-parse-financial;57;61;59;58;56;57;57;77;57;56 01:54:45 INFO - PROCESS | 1674 | |9;json-stringify-tinderbox;63;64;67;75;82;101;96;92;68;69 01:54:45 INFO - PROCESS | 1674 | |10;stanford-crypto-aes;81;83;80;82;83;82;81;81;83;83 01:54:45 INFO - PROCESS | 1674 | |11;stanford-crypto-ccm;142;150;152;137;148;153;157;141;173;190 01:54:45 INFO - PROCESS | 1674 | |12;stanford-crypto-pbkdf2;169;169;168;168;169;167;165;174;176;167 01:54:45 INFO - PROCESS | 1674 | |13;stanford-crypto-sha256-iterative;68;69;69;69;68;71;69;69;67;70 01:54:45 INFO - PROCESS | 1674 | __end_tp_report 01:54:45 INFO - PROCESS | 1674 | __start_cc_report 01:54:45 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,1991 01:54:45 INFO - PROCESS | 1674 | __end_cc_report 01:54:45 INFO - PROCESS | 1674 | __startTimestamp1460969685388__endTimestamp 01:54:45 INFO - PROCESS | 1674 | 01:54:45 INFO - PROCESS | 1674 | ------- Summary: start ------- 01:54:45 INFO - PROCESS | 1674 | Number of tests: 14 01:54:45 INFO - PROCESS | 1674 | 01:54:45 INFO - PROCESS | 1674 | [#0] ai-astar Cycles:10 Average:112.20 Median:112.00 stddev:1.75 (1.6%) stddev-sans-first:1.80 01:54:45 INFO - PROCESS | 1674 | Values: 111.0 109.0 112.0 113.0 112.0 112.0 116.0 112.0 113.0 112.0 01:54:45 INFO - PROCESS | 1674 | 01:54:45 INFO - PROCESS | 1674 | [#1] audio-beat-detection Cycles:10 Average:146.50 Median:149.50 stddev:25.06 (16.8%) stddev-sans-first:26.39 01:54:45 INFO - PROCESS | 1674 | Values: 155.0 134.0 183.0 184.0 119.0 144.0 140.0 120.0 167.0 119.0 01:54:45 INFO - PROCESS | 1674 | 01:54:45 INFO - PROCESS | 1674 | [#2] audio-dft Cycles:10 Average:184.20 Median:185.50 stddev:1.99 (1.1%) stddev-sans-first:2.00 01:54:45 INFO - PROCESS | 1674 | Values: 186.0 185.0 186.0 184.0 186.0 183.0 186.0 183.0 183.0 180.0 01:54:45 INFO - PROCESS | 1674 | 01:54:45 INFO - PROCESS | 1674 | [#3] audio-fft Cycles:10 Average:79.20 Median:63.00 stddev:33.17 (52.6%) stddev-sans-first:35.11 01:54:45 INFO - PROCESS | 1674 | Values: 73.0 75.0 73.0 148.0 55.0 56.0 64.0 62.0 132.0 54.0 01:54:45 INFO - PROCESS | 1674 | 01:54:45 INFO - PROCESS | 1674 | [#4] audio-oscillator Cycles:10 Average:95.40 Median:78.50 stddev:21.99 (28.0%) stddev-sans-first:23.24 01:54:45 INFO - PROCESS | 1674 | Values: 90.0 96.0 133.0 78.0 77.0 80.0 124.0 79.0 77.0 120.0 01:54:45 INFO - PROCESS | 1674 | 01:54:45 INFO - PROCESS | 1674 | [#5] imaging-gaussian-blur Cycles:10 Average:86.50 Median:87.00 stddev:1.51 (1.7%) stddev-sans-first:1.50 01:54:45 INFO - PROCESS | 1674 | Values: 88.0 86.0 87.0 85.0 89.0 87.0 87.0 85.0 87.0 84.0 01:54:45 INFO - PROCESS | 1674 | 01:54:45 INFO - PROCESS | 1674 | [#6] imaging-darkroom Cycles:10 Average:92.90 Median:93.00 stddev:0.74 (0.8%) stddev-sans-first:0.67 01:54:45 INFO - PROCESS | 1674 | Values: 94.0 93.0 93.0 94.0 92.0 92.0 93.0 93.0 92.0 93.0 01:54:45 INFO - PROCESS | 1674 | 01:54:45 INFO - PROCESS | 1674 | [#7] imaging-desaturate Cycles:10 Average:85.00 Median:85.00 stddev:1.15 (1.4%) stddev-sans-first:1.22 01:54:45 INFO - PROCESS | 1674 | Values: 85.0 85.0 84.0 86.0 87.0 85.0 86.0 83.0 85.0 84.0 01:54:45 INFO - PROCESS | 1674 | 01:54:45 INFO - PROCESS | 1674 | [#8] json-parse-financial Cycles:10 Average:59.50 Median:57.50 stddev:6.33 (11.0%) stddev-sans-first:6.65 01:54:45 INFO - PROCESS | 1674 | Values: 57.0 61.0 59.0 58.0 56.0 57.0 57.0 77.0 57.0 56.0 01:54:45 INFO - PROCESS | 1674 | 01:54:45 INFO - PROCESS | 1674 | [#9] json-stringify-tinderbox Cycles:10 Average:77.70 Median:72.00 stddev:14.13 (19.6%) stddev-sans-first:13.95 01:54:45 INFO - PROCESS | 1674 | Values: 63.0 64.0 67.0 75.0 82.0 101.0 96.0 92.0 68.0 69.0 01:54:45 INFO - PROCESS | 1674 | 01:54:45 INFO - PROCESS | 1674 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:82.50 stddev:1.10 (1.3%) stddev-sans-first:1.12 01:54:45 INFO - PROCESS | 1674 | Values: 81.0 83.0 80.0 82.0 83.0 82.0 81.0 81.0 83.0 83.0 01:54:45 INFO - PROCESS | 1674 | 01:54:45 INFO - PROCESS | 1674 | [#11] stanford-crypto-ccm Cycles:10 Average:154.30 Median:152.50 stddev:16.07 (10.5%) stddev-sans-first:16.42 01:54:45 INFO - PROCESS | 1674 | Values: 142.0 150.0 152.0 137.0 148.0 153.0 157.0 141.0 173.0 190.0 01:54:45 INFO - PROCESS | 1674 | 01:54:45 INFO - PROCESS | 1674 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.20 Median:169.00 stddev:3.33 (2.0%) stddev-sans-first:3.53 01:54:45 INFO - PROCESS | 1674 | Values: 169.0 169.0 168.0 168.0 169.0 167.0 165.0 174.0 176.0 167.0 01:54:45 INFO - PROCESS | 1674 | 01:54:45 INFO - PROCESS | 1674 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:1.10 (1.6%) stddev-sans-first:1.12 01:54:45 INFO - PROCESS | 1674 | Values: 68.0 69.0 69.0 69.0 68.0 71.0 69.0 69.0 67.0 70.0 01:54:45 INFO - PROCESS | 1674 | -------- Summary: end -------- 01:54:45 INFO - PROCESS | 1674 | 01:54:46 INFO - TEST-INFO | 1674: exit 0 01:54:46 INFO - TEST-OK | kraken | took 58673ms 01:54:46 INFO - SUITE-END | took 1173s 01:54:46 INFO - Completed test suite (00:19:33) 01:54:46 INFO - javascript benchmark 01:54:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2953.556966455032, 3337.616174139974, 3437.604675462321, 3450.8964731058077, 3488.8081155536433, 5545.3622833374175, 5616.5506759459295, 5629.493345598895, 5641.210230567724, 5644.294463192101, 4769.737664428464, 5628.43715628437, 5673.0, 5695.345035320929, 5787.363390027093, 5081.949180508184, 5120.257562653413, 5121.155009423441, 5146.022255771391, 5333.493318134771, 5234.398044224906, 5255.816046438375, 5261.394939581959, 5288.418273989858, 5304.0, 5075.238714192864, 5150.124478838607, 5150.407703114152, 5225.686458812484, 5278.996990571779, 5193.272941788153, 5202.375714914235, 5205.063088644042, 5205.765740541685, 5219.869503262411, 5081.881985963082, 5150.150225212836, 5190.091733946544, 5195.064888320101, 5217.0, 4235.3646952957, 5525.254090697745, 5535.944640553624, 5552.7223638818305, 5557.3331200255825, 6144.815655530341, 6193.194884665009, 6196.814095577095, 6210.937890621126, 6218.31598524162, 6184.381561843825, 6228.252609686821, 6229.750809967596, 6238.968805155945, 6255.311915689271, 5588.524975377098, 5588.804391846266, 5709.058005429058, 5721.4850663440075, 5732.3407808101765, 6249.781257656051, 6274.843128921813, 6284.842878928063, 6295.905561416583, 6298.559100862987, 6029.0, 6081.148639190517, 6084.6349219047, 6098.939010609926, 6114.938850611437, 6046.667433291123, 6109.374301065143, 6137.662428566382, 6205.627662340274, 6207.068939659087, 6122.215193971364, 6131.774283661951, 6166.0, 6166.537509686702, 6180.938190618126, 5154.484551544891, 6172.22847144107, 6176.4441200292185, 6179.227596550431, 6201.069839524108, 3934.803259837054, 4801.7118972861745, 4818.277258411266, 4867.634927380461, 4869.366982292279, 4376.299792033323, 4415.867523974286, 4446.444194475691, 4452.732836029849, 4455.0, 5603.10350343943, 5609.943900560942, 5619.634723742944, 5620.634658747168, 5621.7189140542805, 6116.579253789288, 6133.018717005258, 6151.446369826647, 6163.7842675506145, 6278.4035516625845, 5629.54963602919, 5630.577706672016, 5640.041192997201, 5641.887162256732, 5667.234923285304, 5298.311219541435, 5299.44355842631, 5301.496357845998, 5307.761150748149, 5364.9731751341, 6158.507319414436, 6176.536759743038, 6228.159198508234, 6257.217847769029, 6305.5901366411035, 6218.751249950133, 6236.906446403398, 6244.188255526752, 6269.373062693694, 6279.654618995999, 6240.843978900564, 6245.125682404376, 6250.406211409909, 6261.499080073674, 6299.779507717208, 6011.068284415923, 6104.359042300494, 6106.15732346443, 6178.907316390348, 6192.287886892885, 6223.066540018853, 6227.564070515021, 6252.3122456530655, 6252.812415627538, 6253.093301471352, 4841.346418233494, 6045.395460453919, 6056.7274472649715, 6061.605995610271, 6083.878322433615, 5743.1385292206505, 5800.984827655059, 5819.127130930395, 5834.445727655866, 5862.267216597926, 5860.413958604106, 5861.238039054895, 5875.41245875409, 5881.176635271151, 5903.203067585821, 5812.447817457335, 5859.5019423347785, 5887.411258874078, 6046.9697651513225, 6089.665068421279, 5778.248827652378, 5778.971105144616, 5805.564582656402, 5812.244408227072, 5826.388229235869], "value": 5613.5070884969355, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [497.73868718922563, 508.55247382303577, 509.9515546023129, 526.6997811247588, 560.5235549782683, 29128.854355728217, 29556.85221573892, 37217.069573260684, 37935.430968535424, 38778.61221387785, 40683.38974915371, 41269.79365103178, 41335.58664413355, 41335.79332103335, 41400.0, 9446.197073248783, 9701.563429645683, 9705.805883882318, 9708.61165553377, 9710.90289097107, 8527.104654011333, 11564.190506664494, 11899.226550274248, 11907.642770716893, 11949.223300485484, 9845.753856153582, 11514.42427878607, 11630.185886987914, 11642.6507204784, 11651.708707282301, 11456.0, 11639.127065470038, 11646.708832279177, 11647.41762911851, 11700.707482312926, 10684.664416947882, 10879.401632910187, 11502.884971150348, 11611.883881161164, 11843.940780296129, 39452.60547394547, 39876.60123398758, 39899.40150897739, 39937.0, 40031.59968400308, 3218.871245150191, 3291.4898190780227, 3324.6010478742705, 3452.7755695879687, 3531.099569609759, 29246.0, 30696.693033069605, 31272.21819454509, 31375.529367059513, 31417.8429107853, 2626.474705058996, 2693.5420978433517, 2791.4138031013513, 2820.732030457103, 2823.0966090850934, 394675.0, 394857.0, 397771.0, 398905.0, 399712.0, 61913.38086619166, 62459.68770156211, 63052.05421918675, 63064.05403918945, 63284.683576581825, 65823.0, 65930.34069659242, 66067.33932660708, 66145.677086458, 66264.0, 16653.250603722863, 17211.225494852762, 17235.965842049518, 17237.482875513753, 17245.913770431067, 11895.405229738652, 12305.384730763426, 13081.215127092404, 13148.0, 13155.53955611549, 17096.230669619898, 19444.80555194458, 19486.06210832457, 19690.40928772139, 20242.493937651383, 7790.454668173287, 8019.39854510914, 8023.879641805378, 8048.114707382183, 8143.556932920219, 943.7499062748377, 977.3402953006693, 1007.1590222164575, 1018.7453136715822, 1065.227709910309, 29409.823607055478, 29736.405271894873, 29755.0, 29845.701542984727, 29924.850375748418, 1086.9673909782562, 1091.7052395853234, 1097.8572785537829, 1147.2428197389684, 1226.466487078106, 12977.0, 15204.391824327124, 15491.457798976982, 15682.215889205494, 16018.839811601967, 589302.0, 620648.0, 625563.0, 628909.0, 634686.0, 59410.0, 59472.40527594669, 59536.80926381448, 60208.69895650494, 60418.79162416727, 1218.4882349413444, 1322.3850909327016, 1371.854501491246, 1476.0553245922617, 1490.046370322994, 28720.0, 29072.12783616495, 29325.706742932296, 29970.850145750002, 29990.70009299879, 49092.772680683265, 49520.50479495159, 49574.25638615496, 49690.254646179616, 49879.750601246764, 396925.0, 401333.0, 401519.0, 401881.0, 402613.0, 22151.23429017039, 22503.437414064778, 23690.644640330753, 26562.734372656025, 26871.462570748085, 41969.95075123147, 42314.0, 42399.36400953926, 43783.0, 43802.78098609487, 32803.835980819946, 33753.32493350168, 33861.492077618364, 34085.488717668755, 34582.82708586441, 36066.63933360633, 36088.81955590205, 36472.0, 36878.26243475169, 37015.074623134635, 36836.0, 37124.6287537132, 37371.62628373681, 37951.62048379481, 38659.0, 29222.0, 31172.844135779174, 31173.220669483446, 32348.676513234568, 32416.027519174462, 24323.75676243286, 24346.0, 24472.510549789262, 24505.632415514137, 24704.0], "value": 19722.921693377502, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.7349774418058, 396.5301118174963, 399.8980260033692, 405.61061381074165, 408.7976451656431, 14478.13131212128, 18019.189136488858, 19308.710369344455, 20009.699854502174, 20038.59922801545, 15604.06375617461, 18112.094395280248, 19341.129649165785, 19650.901745491254, 20114.59770804583, 5802.738876750545, 5957.314908785502, 6001.549883758714, 6005.459508644221, 6016.217891674076, 5412.729363531827, 5782.681952492632, 5893.793717219898, 6016.007358785795, 6033.064874944391, 5730.885382292373, 5745.856353591152, 5760.7695692172265, 5788.160716696077, 5792.71036448178, 6325.557210995232, 6583.901241481333, 6588.858620948211, 6595.043718660815, 6596.868062638744, 5562.805301814417, 5813.593048486608, 5813.912791308134, 5833.2416785817995, 5842.795502157404, 13307.268100254481, 13542.661433464144, 13604.65988350299, 14635.853641463556, 25273.747262527508, 2190.660447630604, 2209.1826024370926, 2337.637666161748, 2462.384403899025, 2775.653043369579, 9413.90586094144, 9934.9503252484, 9970.102690757867, 10058.698239052841, 10153.847692284622, 1727.3608764756996, 1753.4038426934776, 1764.2942822870825, 1805.341050516552, 1845.049799353334, 103632.48183759108, 106240.0, 108701.0, 110506.9999999992, 110791.44604277008, 11344.149188810872, 11349.54601815918, 11545.538178472934, 11565.537378504934, 11679.299242045505, 14857.182854942866, 14932.70134597302, 14943.327550260046, 14964.551063468114, 14975.850241497663, 5466.644668096561, 7483.438742094365, 8512.446690965067, 8600.279944011223, 8715.084916083846, 6849.554778939353, 6910.516263861582, 6961.0, 8459.027211870714, 8594.5702714864, 3752.2870654575545, 4431.667624928079, 4512.661550383735, 4530.682852200314, 4582.839600613963, 1895.4503194073563, 1957.9314723984592, 1959.4121763470903, 1964.7052942058806, 1967.1344608372272, 898.0, 914.6981496106268, 945.2910317262053, 996.2030375699411, 1051.2273478992934, 19289.228430862888, 20150.66852923574, 20246.190152393738, 20290.391288261377, 20321.18715251403, 949.5726922884729, 949.6486300069018, 965.4593427680521, 999.5551979369111, 1024.2062401638789, 10396.48017599132, 10564.788704225872, 10580.89419105799, 10589.417582032907, 10606.522706478227, 460308.39691603323, 519770.4011479918, 525974.0, 526806.0, 616716.0, 122914.38542807408, 129076.0, 132274.0, 141680.0, 150105.0, 451.41767120414954, 479.9544043315949, 1004.9497525123714, 1053.052252972331, 1053.2785042246087, 10625.574977001143, 10719.98160174782, 11274.379909105079, 11280.605178818701, 11305.378204198849, 35228.31514382124, 37807.62192378041, 50427.4871753848, 50739.74630126826, 52356.95286094333, 48908.51091489182, 62339.0, 63243.0, 63302.0, 63722.0, 5543.362513311021, 7750.534967901944, 7838.843223135391, 7874.488158269694, 8504.702335418231, 11302.83045754298, 12428.875711242772, 12623.684407889876, 13007.674808129872, 13065.934670326587, 10241.692749217535, 10878.129749619853, 10948.315413616376, 11145.052670522771, 11294.94352528232, 11060.17048721333, 11137.498812553617, 11148.721281967692, 11199.21605487608, 11231.38227397501, 10950.288231264942, 11126.721831954266, 11314.60398886035, 11465.656030319104, 11612.88387116118, 8190.631421586162, 8267.586620668822, 8355.415120941476, 8375.246227839523, 8630.964284285676, 11051.72370690739, 11385.259958102697, 11410.660814532836, 11581.957623813898, 11692.123090768397], "value": 9047.954684691758, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1394.2680092951193, 1571.9292631831565, 1578.6921550297693, 1820.4629634257901, 1959.3240332085434, 7154.0, 7798.259165379287, 8758.211760941515, 8769.60536775845, 8793.91206087939, 8399.622017009235, 8611.827763444728, 8619.655213791457, 8628.223459888608, 8643.74068777936, 2111.841611879115, 2366.538524987628, 2419.866907320092, 2451.2156110044793, 2459.987700061497, 2464.544059349026, 2474.492728990562, 2484.6397272395493, 2486.0677246032737, 2486.7761901428867, 2378.0606660369144, 2447.938801529967, 2448.1309135256906, 2451.61483761675, 2451.82837201396, 2126.107035045277, 2355.9764402355927, 2424.9757502424927, 2434.294054724128, 2445.400876785199, 2424.599941009731, 2445.9726914695693, 2463.9260822175365, 2465.8027357811334, 2467.8149138814483, 8429.789255268606, 8568.528730919797, 8590.1839325264, 8591.5704214789, 8594.828103437958, 4207.326827707583, 5344.812931547416, 5358.223057656618, 5383.488568585978, 5387.326584176978, 3368.8820891268933, 3387.915302117442, 3459.7924124552605, 3561.0, 3571.053670777246, 1000.6497725795986, 1022.2844009193594, 1023.0434543701663, 1030.7320096774818, 1031.7833255016455, 11200.887991120066, 11278.154138439568, 11285.097192224684, 11288.435578221057, 11303.095752339794, 4463.308187230984, 4464.464264288306, 4675.836345727951, 4680.297955306732, 4682.41469816273, 9029.819403612022, 9064.50145242018, 9090.318226133066, 9095.863562046574, 9097.954510227406, 5262.105442074857, 5273.499017593323, 5280.392754833167, 5282.260483532308, 5288.471152884757, 3985.5416627087675, 4387.758673273001, 4533.274676051816, 4552.908941821145, 4877.073356062337, 3789.981050094787, 3863.439801228806, 3896.7272290939363, 3916.823742931575, 3933.645971862546, 1066.8318191580208, 1186.211169572242, 1192.8926396624345, 1209.2200530657854, 1217.4947396830394, 791.76247125862, 863.4258218284896, 875.1511034296722, 904.1952662130577, 944.1266828183902, 4945.653804233669, 5669.31968163823, 5702.771889124471, 5910.970445147833, 5989.439200610316, 928.2249321816224, 956.7034219392011, 972.5283237629744, 980.8577756225308, 982.2436723722693, 3349.2966477040095, 3712.7957962311793, 3753.680937120321, 3868.25928332246, 3895.7857317847793, 10362.533685984148, 10809.459527023617, 10902.618408355669, 10925.508352124174, 10937.83593246102, 10447.791044179074, 10568.313059651251, 10864.185186111074, 10873.401962892116, 10914.345139291669, 8126.918730812617, 8153.429259951865, 8271.917280827114, 8296.460730052406, 8313.293370063491, 5362.597805164551, 5553.611247212656, 5581.441855814386, 5648.604597678123, 5707.086866101404, 9864.753381165528, 9883.258755593215, 9916.454594997056, 9975.301728878909, 9978.351407158512, 8892.822143557221, 9292.39599426035, 9803.803923921625, 9958.55186516594, 10059.39643621385, 5765.0, 7379.151397589346, 7379.8155046124275, 7381.889271661037, 7390.0, 7975.641096150571, 8148.348132149295, 8154.959225203836, 8156.673733050611, 8160.143184965493, 7179.246179151114, 7275.454340924346, 7445.4043676506835, 7483.0, 7505.549667019996, 7145.499815013107, 7230.504157614677, 7249.347558719741, 7325.047743793273, 7357.411407087528, 6816.284290149463, 6927.168739751262, 6928.515003949675, 6934.4452443805385, 6951.27011663768, 4549.0901819636865, 4670.602998745145, 4700.412448443944, 4766.1420944228985, 4904.313396124617, 4772.331873537777, 4777.737224452689, 4777.761111944458, 4832.299316599144, 4873.926891096708], "value": 4501.1217207249765, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.21668653396307, 319.9520071989202, 326.3912802623108, 331.9137024373662, 334.3396791337111, 5653.802116925908, 5785.466851284407, 5937.0, 6000.579959402844, 6024.849378765533, 5583.58123140764, 5775.27809023872, 5808.1287806829, 5826.9708651456685, 5910.940890591093, 4252.808623611945, 4399.734136919489, 4403.647708183354, 4416.447944006999, 4496.460424749034, 4439.8446054388105, 4451.1765323415275, 4481.865544033668, 4483.529229430912, 4497.3029180476915, 3428.4514477683574, 4005.5794141615147, 4250.468691413574, 4308.6858508155, 4454.933176002362, 4010.7794071326066, 4207.936880946758, 4304.504981927087, 4450.554944505556, 4466.307722303049, 3879.922401551953, 3891.6886649068006, 3909.6676782473523, 3909.7488803582864, 3947.5460322063045, 4864.9053962858425, 5650.7174641267775, 5658.236138121342, 5675.120356344773, 5714.371419143891, 4343.587359200871, 4528.682992190548, 4948.257761335793, 5058.342415485963, 5153.330067091291, 5537.307836520435, 6206.534509911729, 6259.71831267594, 6260.968695156495, 6316.968415157895, 4245.490541135053, 4274.935875961863, 4277.059047009653, 4280.058387154852, 4296.398504209413, 5533.711373685386, 5980.820575382745, 6296.779612713533, 6542.901856472156, 6592.208934927791, 3884.4950156479476, 4246.681498887596, 4333.414988976511, 4346.239408103569, 4361.9127617447475, 3981.6416522513114, 4052.6150015749045, 4227.773945555754, 4245.490541135084, 4446.199684056836, 4319.956800431955, 4883.975580122076, 5123.641345105882, 5124.410692770304, 5186.86194852109, 6252.374762523802, 6272.0, 6278.4035516625845, 6309.62142271456, 6313.210848643919, 1153.8038533449335, 1294.9741005179844, 1476.5496523560203, 1479.1716638682158, 1514.9621259468602, 917.8347897378536, 995.1690338567232, 997.4613708597421, 1010.2877471382658, 1025.466757286222, 5294.8941021180135, 5797.565182611321, 5810.854728631818, 5815.389384114692, 5816.156657284755, 5724.82641058582, 6120.112583675431, 6426.2931077581425, 6440.516961227927, 6443.548951573439, 5510.701652710892, 5696.629719068247, 5771.509421699203, 5779.133130030529, 5815.185873977646, 3381.18851475649, 3423.9657603424143, 3428.794272343667, 3430.776999495025, 3435.0, 5370.812021579304, 6799.082123913307, 6816.420604248595, 6855.520113592101, 6916.308369163044, 5080.796768129308, 5979.611325263844, 6056.3338032816355, 6627.0, 6690.464762818963, 5978.790742323998, 6190.7523699052435, 6466.224053113657, 6783.966080169567, 6784.6946887389195, 5432.972835135799, 6099.878002440015, 6518.73925042993, 6532.379423954717, 6552.0, 6159.965222779087, 6423.903641445476, 6445.5165862561435, 6457.644829534421, 6461.483081353386, 5678.9617554608085, 6000.339962604197, 6009.549283803644, 6233.480726473271, 6863.588184708933, 4109.568495308069, 4200.096979149375, 4235.639970602533, 4248.426462427533, 4253.255680255881, 6149.96925015372, 6506.251781045051, 6515.383961901191, 6547.672616369067, 6567.408933196035, 5778.983606393516, 6129.509639228761, 6237.345078766845, 6313.463355614824, 6332.905006424815, 5482.684155802658, 6135.601185922901, 6217.564770466024, 6316.589421687576, 6318.368163183829, 5211.863136114175, 5782.814523022855, 6167.229096362955, 6193.783217587363, 6199.535034872493, 5800.274965629296, 6272.560920735687, 6300.495960323072, 6322.494200464043, 6348.809535713936, 5162.0, 5381.044931975073, 6016.338202797776, 6131.478824299985, 6201.875962480815], "value": 4541.498146722978, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [651.703474918912, 727.9526830755997, 756.5838788666232, 758.1470845299037, 791.2206476620531, 14777.926110369446, 15134.318955646995, 15134.848651513481, 15141.772873406908, 15248.542543723692, 13945.442182312696, 14002.369893354798, 14012.0, 14029.36867840947, 15281.006734562246, 935.7707361696393, 941.2752180820764, 945.1021529546923, 947.0860619502179, 947.7346343023964, 909.3997961345514, 915.7847905742145, 916.4318122763896, 917.2341095185528, 920.9585568649427, 976.8681228034195, 977.7604486900719, 979.0796651147933, 981.3326937682373, 981.470006196653, 966.859805328227, 969.9418034917927, 973.7711637765191, 973.9513024348754, 974.7124598243499, 724.8586525627504, 724.8803947348681, 725.5791640848296, 726.2700985509529, 729.4456213277894, 12841.29372884491, 15201.163935983517, 15238.695226095417, 15264.771028434583, 15272.31274592646, 12122.0, 12165.695857603541, 12336.444859981322, 12452.128351015432, 12941.0, 9846.458444785534, 10068.647597334131, 10179.18566514677, 10381.273310868242, 10474.319169253975, 3428.245785927092, 3451.32699123671, 3499.737519686034, 3654.104744337628, 3708.4808126862263, 77184.0, 77475.61262193709, 78468.82296765553, 80016.0, 80093.79859302116, 7804.0, 9152.633894644272, 9204.815903681889, 9225.261979041661, 9427.670031548863, 19836.0, 20695.58608827815, 20735.8963205183, 20741.27405540829, 20768.896155519127, 7472.962635186898, 7477.289657482531, 7479.401647868158, 7551.546907185587, 7629.0, 3855.5566109897723, 3944.1717239379477, 3971.1660551283976, 3998.9600103998587, 4167.624913757776, 3521.2605352876185, 3642.617525159873, 3645.799481028516, 3648.0150359402815, 3649.197176621139, 624.2477814233837, 647.8801421736899, 648.2933602373436, 670.852412469256, 675.2403546010738, 568.6377460546998, 569.1604882797923, 574.7844558290641, 605.2343785111836, 605.4006533531772, 6933.1333583302085, 6983.0, 7041.971952060663, 7455.925440745632, 7975.082865470429, 568.2300482845767, 573.8249833800647, 590.3030123251788, 598.3149294058279, 604.727872457396, 3574.517440145547, 3593.94609080864, 3607.7654952428534, 3678.8528458861883, 3808.9238215236096, 87498.56250718706, 88929.77675558033, 89807.0, 90449.54775226081, 90669.09330906738, 56103.0, 70823.0, 71724.99999999895, 71937.28062719306, 74322.62838685772, 60017.0, 65774.34225657683, 66217.0, 66377.66811165914, 67970.98043529352, 7070.7525236616475, 7218.061651985418, 7255.419566434567, 7486.288802563748, 7544.773656790305, 34451.65548344485, 42029.579704202566, 42524.78737606292, 43378.56621433745, 44475.0, 52398.73800630972, 60468.39531604804, 60954.0, 61035.0, 61055.0, 8283.668653254044, 8287.378446616407, 8346.707865224687, 8355.95822020886, 8358.247757701836, 10582.312149710553, 10602.363858168535, 10767.892321077003, 11053.613123540637, 11563.6530904073, 8217.589120544068, 9791.559379827782, 9896.851547226654, 9912.15746661513, 10201.0, 9944.45305508204, 10002.649907253211, 10036.548355323883, 10129.240306976859, 10354.0, 9513.0, 9544.475053872104, 9562.426254424758, 9672.661456848977, 9899.802003960025, 8429.4942303462, 8517.95741021291, 8525.232729054414, 8585.098564650621, 8736.91263087361, 8132.878006829784, 8255.0, 8413.07456179832, 8432.53621050848, 8610.870836937325], "value": 6563.038417071734, "unit": "score"}], "name": "dromaeo_css", "value": 7157.099602688318, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 109.0, 112.0, 113.0, 112.0, 112.0, 116.0, 112.0, 113.0, 112.0], "value": 112.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 134.0, 183.0, 184.0, 119.0, 144.0, 140.0, 120.0, 167.0, 119.0], "value": 146.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 185.0, 186.0, 184.0, 186.0, 183.0, 186.0, 183.0, 183.0, 180.0], "value": 184.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 73.0, 148.0, 55.0, 56.0, 64.0, 62.0, 132.0, 54.0], "value": 79.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 96.0, 133.0, 78.0, 77.0, 80.0, 124.0, 79.0, 77.0, 120.0], "value": 95.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 87.0, 85.0, 89.0, 87.0, 87.0, 85.0, 87.0, 84.0], "value": 86.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 93.0, 94.0, 92.0, 92.0, 93.0, 93.0, 92.0, 93.0], "value": 92.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 86.0, 87.0, 85.0, 86.0, 83.0, 85.0, 84.0], "value": 85.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 61.0, 59.0, 58.0, 56.0, 57.0, 57.0, 77.0, 57.0, 56.0], "value": 59.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 67.0, 75.0, 82.0, 101.0, 96.0, 92.0, 68.0, 69.0], "value": 77.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 83.0, 80.0, 82.0, 83.0, 82.0, 81.0, 81.0, 83.0, 83.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 150.0, 152.0, 137.0, 148.0, 153.0, 157.0, 141.0, 173.0, 190.0], "value": 154.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 169.0, 168.0, 168.0, 169.0, 167.0, 165.0, 174.0, 176.0, 167.0], "value": 169.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 69.0, 69.0, 68.0, 71.0, 69.0, 69.0, 67.0, 70.0], "value": 68.9, "unit": "score"}], "name": "kraken", "value": 1493.4, "alertThreshold": 2.0}]} 01:54:46 INFO - Return code: 0 01:54:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:54:46 ERROR - # TBPL SUCCESS # 01:54:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:54:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:54:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:54:46 INFO - 2016-04-18 01:54:46.666 screenresolution[1678:9734] starting screenresolution argv=screenresolution get 01:54:46 INFO - 2016-04-18 01:54:46.668 screenresolution[1678:9734] Display 0: 1600x1200x32@60 01:54:46 INFO - 2016-04-18 01:54:46.674 screenresolution[1679:9737] starting screenresolution argv=screenresolution list 01:54:46 INFO - Available Modes on Display 0 01:54:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:54:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:54:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:54:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:54:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:54:46 INFO - Intel Iris: 01:54:46 INFO - Chipset Model: Intel Iris 01:54:46 INFO - Type: GPU 01:54:46 INFO - Bus: Built-In 01:54:46 INFO - VRAM (Dynamic, Max): 1536 MB 01:54:46 INFO - Vendor: Intel (0x8086) 01:54:46 INFO - Device ID: 0x0a2e 01:54:46 INFO - Revision ID: 0x0009 01:54:46 INFO - Displays: 01:54:46 INFO - Display: 01:54:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:54:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:54:46 INFO - Display Serial Number: 1600x1200 60 01:54:46 INFO - Main Display: Yes 01:54:46 INFO - Mirror: Off 01:54:46 INFO - Online: Yes 01:54:46 INFO - Rotation: Supported 01:54:46 INFO - Return code: 0 01:54:46 INFO - Running post-action listener: _resource_record_post_action 01:54:46 INFO - Running post-run listener: _resource_record_post_run 01:54:47 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 37279232; Write bytes: 692978688; Read time: 389; Write time: 2063 01:54:47 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 395362816; Write bytes: 384321024; Read time: 29376; Write time: 674 01:54:47 INFO - run-tests - Wall time: 1176s; CPU: 53.0%; Read bytes: 30154240; Write bytes: 295247360; Read time: 301; Write time: 1360 01:54:47 INFO - Running post-run listener: _upload_blobber_files 01:54:47 INFO - Blob upload gear active. 01:54:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:54:47 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 01:54:47 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'] 01:54:47 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 01:54:48 INFO - (blobuploader) - INFO - Open directory for files ... 01:54:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:54:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:54:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:54:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:54:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:54:49 INFO - (blobuploader) - INFO - Done attempting. 01:54:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:54:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:54:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:54:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:54:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:54:50 INFO - (blobuploader) - INFO - Done attempting. 01:54:50 INFO - (blobuploader) - INFO - Iteration through files over. 01:54:50 INFO - Return code: 0 01:54:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:54:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:54:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3873eec2ee4c80794cef39f93a993b3679313e8f1d7c2327c24aa3f6dc5ceed27e675aad917a82a0e1f5e1bb0234c8f83327f14228215aec84ba2fdb93fb95ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8641693c676101802254dc9c0f621a0e489c7ac7e8751ee93ce9e926310f509078f958e33b5685c4052812722d06d4d1357488dca9493054cfda720e86275ede"} 01:54:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:54:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:54:50 INFO - Contents: 01:54:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3873eec2ee4c80794cef39f93a993b3679313e8f1d7c2327c24aa3f6dc5ceed27e675aad917a82a0e1f5e1bb0234c8f83327f14228215aec84ba2fdb93fb95ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8641693c676101802254dc9c0f621a0e489c7ac7e8751ee93ce9e926310f509078f958e33b5685c4052812722d06d4d1357488dca9493054cfda720e86275ede"} 01:54:50 INFO - Running post-run listener: copy_logs_to_upload_dir 01:54:50 INFO - Copying logs to upload dir... 01:54:50 INFO - mkdir: /builds/slave/test/build/upload/logs 01:54:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1288.121247 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2016-04-18 01:54:50.620453) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 01:54:50.624137) ========= 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.8h5PI8SdKw/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.GousUrOCrg/Listeners TMPDIR=/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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/3873eec2ee4c80794cef39f93a993b3679313e8f1d7c2327c24aa3f6dc5ceed27e675aad917a82a0e1f5e1bb0234c8f83327f14228215aec84ba2fdb93fb95ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8641693c676101802254dc9c0f621a0e489c7ac7e8751ee93ce9e926310f509078f958e33b5685c4052812722d06d4d1357488dca9493054cfda720e86275ede"} build_url:https://queue.taskcluster.net/v1/task/NeMjG6faS6mIUkKbUW5-rg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011080 build_url: 'https://queue.taskcluster.net/v1/task/NeMjG6faS6mIUkKbUW5-rg/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/3873eec2ee4c80794cef39f93a993b3679313e8f1d7c2327c24aa3f6dc5ceed27e675aad917a82a0e1f5e1bb0234c8f83327f14228215aec84ba2fdb93fb95ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8641693c676101802254dc9c0f621a0e489c7ac7e8751ee93ce9e926310f509078f958e33b5685c4052812722d06d4d1357488dca9493054cfda720e86275ede"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 01:54:50.657561) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 01:54:50.658014) ========= 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.8h5PI8SdKw/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.GousUrOCrg/Listeners TMPDIR=/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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.005224 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 01:54:50.710603) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 01:54:50.711311) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 01:54:50.712476) ========= ========= Total master_lag: 0.16 =========