builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0344 starttime: 1464360841.15 results: success (0) buildid: 20160527053644 builduid: 70899685370c4d899c113fabe58a40e2 revision: df3281895c93b96241347e8c6a699256bcb3970c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 07:54:01.146878) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 07:54:01.147833) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 07:54:01.148396) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 07:54:01.317595) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 07:54:01.317952) ========= 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.BxG5FsD0qR/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.DH41pVV7hp/Listeners TMPDIR=/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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-05-27 07:54:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.0M=0.001s 2016-05-27 07:54:01 (18.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.246563 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 07:54:01.592144) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 07:54:01.592488) ========= 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.BxG5FsD0qR/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.DH41pVV7hp/Listeners TMPDIR=/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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.025789 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 07:54:01.640846) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 07:54:01.641245) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev df3281895c93b96241347e8c6a699256bcb3970c --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 df3281895c93b96241347e8c6a699256bcb3970c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BxG5FsD0qR/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.DH41pVV7hp/Listeners TMPDIR=/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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-05-27 07:54:01,723 truncating revision to first 12 chars 2016-05-27 07:54:01,723 Setting DEBUG logging. 2016-05-27 07:54:01,723 attempt 1/10 2016-05-27 07:54:01,724 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/df3281895c93?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-27 07:54:02,396 unpacking tar archive at: fx-team-df3281895c93/testing/mozharness/ program finished with exit code 0 elapsedTime=0.926275 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 07:54:02.590807) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 07:54:02.591539) ========= script_repo_revision: df3281895c93b96241347e8c6a699256bcb3970c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 07:54:02.592529) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 07:54:02.593205) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 07:54:02.610775) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 40 secs) (at 2016-05-27 07:54:02.611123) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.BxG5FsD0qR/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.DH41pVV7hp/Listeners TMPDIR=/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 07:54:02 INFO - MultiFileLogger online at 20160527 07:54:02 in /builds/slave/test 07:54:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 07:54:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:54:02 INFO - {'append_to_log': False, 07:54:02 INFO - 'base_work_dir': '/builds/slave/test', 07:54:02 INFO - 'blob_upload_branch': 'Fx-Team', 07:54:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:54:02 INFO - 'branch': 'Fx-Team', 07:54:02 INFO - 'buildbot_json_path': 'buildprops.json', 07:54:02 INFO - 'config_files': ('talos/mac_config.py',), 07:54:02 INFO - 'default_actions': ('clobber', 07:54:02 INFO - 'read-buildbot-config', 07:54:02 INFO - 'download-and-extract', 07:54:02 INFO - 'populate-webroot', 07:54:02 INFO - 'create-virtualenv', 07:54:02 INFO - 'install', 07:54:02 INFO - 'run-tests'), 07:54:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:54:02 INFO - 'download_minidump_stackwalk': True, 07:54:02 INFO - 'download_symbols': 'ondemand', 07:54:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:54:02 INFO - 'tooltool.py': '/tools/tooltool.py', 07:54:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:54:02 INFO - '/tools/misc-python/virtualenv.py')}, 07:54:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:54:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:54:02 INFO - 'installer_path': 'installer.exe', 07:54:02 INFO - 'log_level': 'info', 07:54:02 INFO - 'log_name': 'talos', 07:54:02 INFO - 'log_to_console': True, 07:54:02 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:54:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:54:02 INFO - 'opt_config_files': (), 07:54:02 INFO - 'pip_index': False, 07:54:02 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:54:02 INFO - 'cmd': ('bash', 07:54:02 INFO - '-c', 07:54:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:54:02 INFO - 'enabled': True, 07:54:02 INFO - 'halt_on_failure': False, 07:54:02 INFO - 'name': 'check_screen_resolution'},), 07:54:02 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:54:02 INFO - 'cmd': ('bash', 07:54:02 INFO - '-c', 07:54:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:54:02 INFO - 'enabled': True, 07:54:02 INFO - 'halt_on_failure': False, 07:54:02 INFO - 'name': 'check_screen_resolution'},), 07:54:02 INFO - 'run_cmd_checks_enabled': True, 07:54:02 INFO - 'sps_profile': False, 07:54:02 INFO - 'sps_profile_interval': 0, 07:54:02 INFO - 'suite': 'dromaeojs-e10s', 07:54:02 INFO - 'system_bits': '32', 07:54:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:54:02 INFO - 'title': 't-yosemite-r7-0344', 07:54:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:54:02 INFO - 'use_talos_json': True, 07:54:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:54:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:54:02 INFO - 'work_dir': 'build'} 07:54:02 INFO - ##### 07:54:02 INFO - ##### Running clobber step. 07:54:02 INFO - ##### 07:54:02 INFO - Running pre-action listener: _resource_record_pre_action 07:54:02 INFO - Running main action method: clobber 07:54:02 INFO - rmtree: /builds/slave/test/build 07:54:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:54:04 INFO - Running post-action listener: _resource_record_post_action 07:54:04 INFO - ##### 07:54:04 INFO - ##### Finished clobber step (success) 07:54:04 INFO - ##### 07:54:04 INFO - ##### 07:54:04 INFO - ##### Running read-buildbot-config step. 07:54:04 INFO - ##### 07:54:04 INFO - Running pre-action listener: _resource_record_pre_action 07:54:04 INFO - Running main action method: read_buildbot_config 07:54:04 INFO - Using buildbot properties: 07:54:04 INFO - { 07:54:04 INFO - "project": "", 07:54:04 INFO - "product": "firefox", 07:54:04 INFO - "script_repo_revision": "production", 07:54:04 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 07:54:04 INFO - "repository": "", 07:54:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 07:54:04 INFO - "buildid": "20160527053644", 07:54:04 INFO - "pgo_build": "False", 07:54:04 INFO - "basedir": "/builds/slave/test", 07:54:04 INFO - "buildnumber": 20, 07:54:04 INFO - "slavename": "t-yosemite-r7-0344", 07:54:04 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 07:54:04 INFO - "platform": "yosemite_r7", 07:54:04 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 07:54:04 INFO - "branch": "fx-team", 07:54:04 INFO - "repo_path": "integration/fx-team", 07:54:04 INFO - "revision": "df3281895c93b96241347e8c6a699256bcb3970c", 07:54:04 INFO - "stage_platform": "macosx64", 07:54:04 INFO - "builduid": "70899685370c4d899c113fabe58a40e2", 07:54:04 INFO - "slavebuilddir": "test" 07:54:04 INFO - } 07:54:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/BMi-wQBRQge783nRqNABZw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 07:54:04 INFO - Running post-action listener: _resource_record_post_action 07:54:04 INFO - ##### 07:54:04 INFO - ##### Finished read-buildbot-config step (success) 07:54:04 INFO - ##### 07:54:04 INFO - ##### 07:54:04 INFO - ##### Running download-and-extract step. 07:54:04 INFO - ##### 07:54:04 INFO - Running pre-action listener: _resource_record_pre_action 07:54:04 INFO - Running main action method: download_and_extract 07:54:04 INFO - mkdir: /builds/slave/test/build/tests 07:54:04 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')]} 07:54:04 INFO - https://queue.taskcluster.net/v1/task/BMi-wQBRQge783nRqNABZw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 07:54:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMi-wQBRQge783nRqNABZw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 07:54:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMi-wQBRQge783nRqNABZw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 07:54:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMi-wQBRQge783nRqNABZw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 07:54:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMi-wQBRQge783nRqNABZw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #1 07:54:18 INFO - Downloaded 1199 bytes. 07:54:18 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 07:54:18 INFO - Using the following test package requirements: 07:54:18 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 07:54:18 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 07:54:18 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 07:54:18 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 07:54:18 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 07:54:18 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 07:54:18 INFO - u'jsshell-mac.zip'], 07:54:18 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 07:54:18 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 07:54:18 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 07:54:18 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 07:54:18 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 07:54:18 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 07:54:18 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 07:54:18 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 07:54:18 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 07:54:18 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 07:54:18 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 07:54:18 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:54: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')]} 07:54:18 INFO - https://queue.taskcluster.net/v1/task/BMi-wQBRQge783nRqNABZw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:54:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMi-wQBRQge783nRqNABZw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 07:54:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMi-wQBRQge783nRqNABZw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 07:54:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMi-wQBRQge783nRqNABZw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 07:54:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMi-wQBRQge783nRqNABZw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:54:41 INFO - Downloaded 18684821 bytes. 07:54:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:54:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 07:54:44 INFO - Return code: 0 07:54:44 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip', u'firefox-49.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 07:54: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')]} 07:54:44 INFO - https://queue.taskcluster.net/v1/task/BMi-wQBRQge783nRqNABZw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:54:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMi-wQBRQge783nRqNABZw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 07:54:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMi-wQBRQge783nRqNABZw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 07:54:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMi-wQBRQge783nRqNABZw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 07:54:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMi-wQBRQge783nRqNABZw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:54:45 INFO - Downloaded 18684821 bytes. 07:54:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:54:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 07:54:49 INFO - Return code: 0 07:54: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')]} 07:54:49 INFO - https://queue.taskcluster.net/v1/task/BMi-wQBRQge783nRqNABZw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 07:54:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMi-wQBRQge783nRqNABZw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 07:54:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMi-wQBRQge783nRqNABZw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 07:54:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMi-wQBRQge783nRqNABZw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip 07:54:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMi-wQBRQge783nRqNABZw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip'}, attempt #1 07:54:50 INFO - Downloaded 10834034 bytes. 07:54:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:54:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 07:54:50 INFO - Return code: 0 07:54:50 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')]} 07:54:50 INFO - https://queue.taskcluster.net/v1/task/BMi-wQBRQge783nRqNABZw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 07:54:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMi-wQBRQge783nRqNABZw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 07:54:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMi-wQBRQge783nRqNABZw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 07:54:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMi-wQBRQge783nRqNABZw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 07:54:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMi-wQBRQge783nRqNABZw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg'}, attempt #1 07:54:53 INFO - Downloaded 110476488 bytes. 07:54:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BMi-wQBRQge783nRqNABZw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 07:54:53 INFO - mkdir: /builds/slave/test/properties 07:54:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:54:53 INFO - Writing to file /builds/slave/test/properties/build_url 07:54:53 INFO - Contents: 07:54:53 INFO - build_url:https://queue.taskcluster.net/v1/task/BMi-wQBRQge783nRqNABZw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 07:54:54 INFO - Running post-action listener: _resource_record_post_action 07:54:54 INFO - Running post-action listener: set_extra_try_arguments 07:54:54 INFO - ##### 07:54:54 INFO - ##### Finished download-and-extract step (success) 07:54:54 INFO - ##### 07:54:54 INFO - ##### 07:54:54 INFO - ##### Running populate-webroot step. 07:54:54 INFO - ##### 07:54:54 INFO - Running pre-action listener: _resource_record_pre_action 07:54:54 INFO - Running main action method: populate_webroot 07:54:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:54:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:54:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:54:54 INFO - '--tppagecycles', 07:54:54 INFO - '7'], 07:54:54 INFO - 'tests': ['tsvgm']}}, 07:54:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:54:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:54:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:54:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:54:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:54:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:54:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:54:54 INFO - 'talos_options': ['--disable-e10s'], 07:54:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:54:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:54:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:54:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:54:54 INFO - 'talos_options': ['--disable-e10s'], 07:54:54 INFO - 'tests': ['damp', 'tps']}, 07:54:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:54:54 INFO - 'tests': ['damp', 'tps']}, 07:54:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:54:54 INFO - 'tests': ['dromaeo_dom']}, 07:54:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:54:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:54:54 INFO - 'tests': ['a11yr', 07:54:54 INFO - 'ts_paint', 07:54:54 INFO - 'tpaint', 07:54:54 INFO - 'sessionrestore', 07:54:54 INFO - 'sessionrestore_no_auto_restore', 07:54:54 INFO - 'tabpaint']}, 07:54:54 INFO - 'other-e10s': {'tests': ['a11yr', 07:54:54 INFO - 'ts_paint', 07:54:54 INFO - 'tpaint', 07:54:54 INFO - 'sessionrestore', 07:54:54 INFO - 'sessionrestore_no_auto_restore', 07:54:54 INFO - 'tabpaint']}, 07:54:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:54:54 INFO - 'ts_paint', 07:54:54 INFO - 'tpaint', 07:54:54 INFO - 'sessionrestore', 07:54:54 INFO - 'sessionrestore_no_auto_restore', 07:54:54 INFO - 'tabpaint']}, 07:54:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:54:54 INFO - 'ts_paint', 07:54:54 INFO - 'tpaint', 07:54:54 INFO - 'sessionrestore', 07:54:54 INFO - 'sessionrestore_no_auto_restore', 07:54:54 INFO - 'tabpaint']}, 07:54:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:54:54 INFO - 'tests': ['a11yr', 07:54:54 INFO - 'ts_paint', 07:54:54 INFO - 'tpaint', 07:54:54 INFO - 'sessionrestore', 07:54:54 INFO - 'sessionrestore_no_auto_restore', 07:54:54 INFO - 'tabpaint']}, 07:54:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:54:54 INFO - 'tests': ['a11yr', 07:54:54 INFO - 'ts_paint', 07:54:54 INFO - 'tpaint', 07:54:54 INFO - 'sessionrestore', 07:54:54 INFO - 'sessionrestore_no_auto_restore', 07:54:54 INFO - 'tabpaint']}, 07:54:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:54:54 INFO - 'tests': ['tsvgx', 07:54:54 INFO - 'tsvgr_opacity', 07:54:54 INFO - 'tart', 07:54:54 INFO - 'tscrollx', 07:54:54 INFO - 'cart']}, 07:54:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:54:54 INFO - 'tsvgr_opacity', 07:54:54 INFO - 'tart', 07:54:54 INFO - 'tscrollx', 07:54:54 INFO - 'cart']}, 07:54:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:54:54 INFO - 'talos_options': ['--disable-e10s'], 07:54:54 INFO - 'tests': ['tp5o']}, 07:54:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:54:54 INFO - 'tests': ['tp5o']}, 07:54:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:54:54 INFO - 'talos_options': ['--disable-e10s', 07:54:54 INFO - '--xperf_path', 07:54:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:54:54 INFO - 'tests': ['tp5n']}, 07:54:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:54:54 INFO - 'talos_options': ['--xperf_path', 07:54:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:54:54 INFO - 'tests': ['tp5n']}}, 07:54:54 INFO - 'talos.zip': {'path': '', 07:54:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:54:54 INFO - Running post-action listener: _resource_record_post_action 07:54:54 INFO - ##### 07:54:54 INFO - ##### Finished populate-webroot step (success) 07:54:54 INFO - ##### 07:54:54 INFO - ##### 07:54:54 INFO - ##### Running create-virtualenv step. 07:54:54 INFO - ##### 07:54:54 INFO - Running pre-action listener: _resource_record_pre_action 07:54:54 INFO - Running main action method: create_virtualenv 07:54:54 INFO - Creating virtualenv /builds/slave/test/build/venv 07:54:54 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 07:54:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:54:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:54:54 INFO - Using real prefix '/tools/python27' 07:54:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:54:55 INFO - Installing distribute.............................................................................................................................................................................................done. 07:54:58 INFO - Installing pip.................done. 07:54:58 INFO - Return code: 0 07:54:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:54:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:54:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:54:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101f5fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f65570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3b24ba200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e03d30>, '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 0x101c27db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101dfab20>, '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.BxG5FsD0qR/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.DH41pVV7hp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 07:54:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:54:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:54:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BxG5FsD0qR/Render', 07:54:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:54:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:54:58 INFO - 'HOME': '/Users/cltbld', 07:54:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:54:58 INFO - 'LOGNAME': 'cltbld', 07:54:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:58 INFO - 'MOZ_NO_REMOTE': '1', 07:54:58 INFO - 'NO_EM_RESTART': '1', 07:54:58 INFO - 'PAGER': '/bin/cat', 07:54:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:54:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:58 INFO - 'PWD': '/builds/slave/test', 07:54:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:54:58 INFO - 'SHELL': '/bin/bash', 07:54:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DH41pVV7hp/Listeners', 07:54:58 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 07:54:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:54:58 INFO - 'USER': 'cltbld', 07:54:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:54:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:54:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:58 INFO - 'XPC_FLAGS': '0x0', 07:54:58 INFO - 'XPC_SERVICE_NAME': '0', 07:54:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:54:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:58 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 07:54:58 INFO - Cleaning up... 07:54:58 INFO - Return code: 0 07:54:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:54:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:54:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:54:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101f5fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f65570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3b24ba200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e03d30>, '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 0x101c27db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101dfab20>, '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.BxG5FsD0qR/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.DH41pVV7hp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 07:54:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:54:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:54:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BxG5FsD0qR/Render', 07:54:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:54:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:54:58 INFO - 'HOME': '/Users/cltbld', 07:54:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:54:58 INFO - 'LOGNAME': 'cltbld', 07:54:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:58 INFO - 'MOZ_NO_REMOTE': '1', 07:54:58 INFO - 'NO_EM_RESTART': '1', 07:54:58 INFO - 'PAGER': '/bin/cat', 07:54:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:54:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:58 INFO - 'PWD': '/builds/slave/test', 07:54:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:54:58 INFO - 'SHELL': '/bin/bash', 07:54:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DH41pVV7hp/Listeners', 07:54:58 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 07:54:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:54:58 INFO - 'USER': 'cltbld', 07:54:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:54:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:54:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:58 INFO - 'XPC_FLAGS': '0x0', 07:54:58 INFO - 'XPC_SERVICE_NAME': '0', 07:54:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:54:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:59 INFO - Downloading/unpacking psutil>=3.1.1 07:54:59 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 07:54:59 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 07:54:59 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 07:54:59 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 07:54:59 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 07:54:59 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 07:55:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:55:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:55:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:55:02 INFO - Installing collected packages: psutil 07:55:02 INFO - Running setup.py install for psutil 07:55:02 INFO - building 'psutil._psutil_osx' extension 07:55:02 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 07:55:02 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 07:55:03 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 07:55:03 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 07:55:03 INFO - building 'psutil._psutil_posix' extension 07:55:03 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 07:55:03 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:55:03 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:55:03 INFO - ^ 07:55:03 INFO - 1 warning generated. 07:55:03 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 07:55:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:55:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:55:03 INFO - Successfully installed psutil 07:55:03 INFO - Cleaning up... 07:55:03 INFO - Return code: 0 07:55:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:55:03 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')]} 07:55:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:03 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')]} 07:55:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101f5fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f65570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3b24ba200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e03d30>, '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 0x101c27db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101dfab20>, '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.BxG5FsD0qR/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.DH41pVV7hp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 07:55:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:55:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:55:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BxG5FsD0qR/Render', 07:55:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:55:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:55:03 INFO - 'HOME': '/Users/cltbld', 07:55:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:55:03 INFO - 'LOGNAME': 'cltbld', 07:55:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:03 INFO - 'MOZ_NO_REMOTE': '1', 07:55:03 INFO - 'NO_EM_RESTART': '1', 07:55:03 INFO - 'PAGER': '/bin/cat', 07:55:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:55:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:55:03 INFO - 'PWD': '/builds/slave/test', 07:55:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:55:03 INFO - 'SHELL': '/bin/bash', 07:55:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DH41pVV7hp/Listeners', 07:55:03 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 07:55:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:55:03 INFO - 'USER': 'cltbld', 07:55:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:55:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:55:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:03 INFO - 'XPC_FLAGS': '0x0', 07:55:03 INFO - 'XPC_SERVICE_NAME': '0', 07:55:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:55:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:55:03 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 07:55:03 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 07:55:03 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 07:55:03 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 07:55:03 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 07:55:03 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 07:55:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:55:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:55:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:55:06 INFO - Installing collected packages: mozsystemmonitor 07:55:06 INFO - Running setup.py install for mozsystemmonitor 07:55:06 INFO - Successfully installed mozsystemmonitor 07:55:06 INFO - Cleaning up... 07:55:06 INFO - Return code: 0 07:55:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:55:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:07 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')]} 07:55:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:07 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 0x101f5fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f65570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3b24ba200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e03d30>, '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 0x101c27db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101dfab20>, '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.BxG5FsD0qR/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.DH41pVV7hp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 07:55:07 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 07:55:07 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 07:55:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BxG5FsD0qR/Render', 07:55:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:55:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:55:07 INFO - 'HOME': '/Users/cltbld', 07:55:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:55:07 INFO - 'LOGNAME': 'cltbld', 07:55:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:07 INFO - 'MOZ_NO_REMOTE': '1', 07:55:07 INFO - 'NO_EM_RESTART': '1', 07:55:07 INFO - 'PAGER': '/bin/cat', 07:55:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:55:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:55:07 INFO - 'PWD': '/builds/slave/test', 07:55:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:55:07 INFO - 'SHELL': '/bin/bash', 07:55:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DH41pVV7hp/Listeners', 07:55:07 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 07:55:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:55:07 INFO - 'USER': 'cltbld', 07:55:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:55:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:55:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:07 INFO - 'XPC_FLAGS': '0x0', 07:55:07 INFO - 'XPC_SERVICE_NAME': '0', 07:55:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:55:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:07 INFO - Downloading/unpacking blobuploader==1.2.4 07:55:07 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 07:55:07 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 07:55:07 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 07:55:07 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 07:55:07 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 07:55:07 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 07:55:09 INFO - Downloading blobuploader-1.2.4.tar.gz 07:55:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:55:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:55:09 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 07:55:09 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 07:55:09 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 07:55:09 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 07:55:09 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 07:55:09 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 07:55:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:55:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:55:10 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 07:55:10 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 07:55:10 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 07:55:10 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 07:55:10 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 07:55:10 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 07:55:10 INFO - Downloading docopt-0.6.1.tar.gz 07:55:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:55:10 INFO - Installing collected packages: blobuploader, requests, docopt 07:55:10 INFO - Running setup.py install for blobuploader 07:55:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:55:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:55:11 INFO - Running setup.py install for requests 07:55:11 INFO - Running setup.py install for docopt 07:55:11 INFO - Successfully installed blobuploader requests docopt 07:55:11 INFO - Cleaning up... 07:55:11 INFO - Return code: 0 07:55:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:55: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')]} 07:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55: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')]} 07:55:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:11 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 0x101f5fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f65570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3b24ba200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e03d30>, '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 0x101c27db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101dfab20>, '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.BxG5FsD0qR/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.DH41pVV7hp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 07:55:11 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 07:55:11 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 07:55:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BxG5FsD0qR/Render', 07:55:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:55:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:55:11 INFO - 'HOME': '/Users/cltbld', 07:55:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:55:11 INFO - 'LOGNAME': 'cltbld', 07:55:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:11 INFO - 'MOZ_NO_REMOTE': '1', 07:55:11 INFO - 'NO_EM_RESTART': '1', 07:55:11 INFO - 'PAGER': '/bin/cat', 07:55:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:55:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:55:11 INFO - 'PWD': '/builds/slave/test', 07:55:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:55:11 INFO - 'SHELL': '/bin/bash', 07:55:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DH41pVV7hp/Listeners', 07:55:11 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 07:55:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:55:11 INFO - 'USER': 'cltbld', 07:55:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:55:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:55:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:11 INFO - 'XPC_FLAGS': '0x0', 07:55:11 INFO - 'XPC_SERVICE_NAME': '0', 07:55:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:55:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:55:12 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-JFz3T2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:55:12 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-ZkWeNc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:55:12 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-FK3LEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:55:12 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-lQntFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:55:12 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-eHcn05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:55:12 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-qFZGCG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:55:12 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-WqbcKS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:55:12 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-AtG_BA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:55:13 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-pUvemE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:55:13 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-_RRV0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:55:13 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-hqj4G9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:55:13 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-a5xcmT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:55:13 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-guDVbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:55:13 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-aWQoS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:55:13 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-VMKxz3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:55:13 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-LAZBz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:55:13 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-6LLNUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:55:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:55:13 INFO - Running setup.py install for manifestparser 07:55:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:55:14 INFO - Running setup.py install for mozcrash 07:55:14 INFO - Running setup.py install for mozdebug 07:55:14 INFO - Running setup.py install for mozdevice 07:55:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:55:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:55:14 INFO - Running setup.py install for mozfile 07:55:14 INFO - Running setup.py install for mozhttpd 07:55:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:55:14 INFO - Running setup.py install for mozinfo 07:55:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:55:15 INFO - Running setup.py install for mozInstall 07:55:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:55:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:55:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:55:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:55:15 INFO - Running setup.py install for mozleak 07:55:15 INFO - Running setup.py install for mozlog 07:55:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:55:15 INFO - Running setup.py install for moznetwork 07:55:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:55:15 INFO - Running setup.py install for mozprocess 07:55:15 INFO - Running setup.py install for mozprofile 07:55:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:55:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:55:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:55:15 INFO - Running setup.py install for mozrunner 07:55:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:55:16 INFO - Running setup.py install for mozscreenshot 07:55:16 INFO - Running setup.py install for moztest 07:55:16 INFO - Running setup.py install for mozversion 07:55:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:55:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:55:16 INFO - Cleaning up... 07:55:16 INFO - Return code: 0 07:55:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:55:16 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')]} 07:55:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:16 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')]} 07:55:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:16 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 0x101f5fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f65570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3b24ba200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e03d30>, '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 0x101c27db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101dfab20>, '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.BxG5FsD0qR/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.DH41pVV7hp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 07:55:16 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 07:55:16 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 07:55:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BxG5FsD0qR/Render', 07:55:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:55:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:55:16 INFO - 'HOME': '/Users/cltbld', 07:55:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:55:16 INFO - 'LOGNAME': 'cltbld', 07:55:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:16 INFO - 'MOZ_NO_REMOTE': '1', 07:55:16 INFO - 'NO_EM_RESTART': '1', 07:55:16 INFO - 'PAGER': '/bin/cat', 07:55:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:55:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:55:16 INFO - 'PWD': '/builds/slave/test', 07:55:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:55:16 INFO - 'SHELL': '/bin/bash', 07:55:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DH41pVV7hp/Listeners', 07:55:16 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 07:55:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:55:16 INFO - 'USER': 'cltbld', 07:55:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:55:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:55:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:16 INFO - 'XPC_FLAGS': '0x0', 07:55:16 INFO - 'XPC_SERVICE_NAME': '0', 07:55:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:55:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:55:16 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-DFVnMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:55:16 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)) 07:55:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:55:16 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-kH7Nrl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:55:17 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)) 07:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:55:17 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-u0MXYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:55:17 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)) 07:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:55:17 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-MUSD0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:55:17 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)) 07:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:55:17 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-28zh9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:55:17 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)) 07:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:55:17 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-DPaSf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:55:17 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)) 07:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:55:17 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-IHctka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:55:17 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)) 07:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:55:17 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-OT0u2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:55:17 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)) 07:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:55:17 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-GgDU21-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:55:17 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)) 07:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:55:17 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-FkpXQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:55:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 07:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:55:17 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-79Grba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:55:18 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)) 07:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:55:18 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-_9wyNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:55:18 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)) 07:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:55:18 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-tmZGyW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:55:18 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)) 07:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:55:18 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-tKloGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:55:18 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)) 07:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:55:18 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-gjZOg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:55:18 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)) 07:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:55:18 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-N0denM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:55:18 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)) 07:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:55:18 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-CpyVCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:55:18 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)) 07:55:18 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)) 07:55:18 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)) 07:55:18 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)) 07:55:18 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)) 07:55:18 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)) 07:55:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:55:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:21 INFO - Downloading blessings-1.6.tar.gz 07:55:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:55:21 INFO - Installing collected packages: blessings 07:55:21 INFO - Running setup.py install for blessings 07:55:21 INFO - Successfully installed blessings 07:55:21 INFO - Cleaning up... 07:55:21 INFO - Return code: 0 07:55:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:55:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:55:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:55:21 INFO - Reading from file tmpfile_stdout 07:55:21 INFO - Current package versions: 07:55:21 INFO - blessings == 1.6 07:55:21 INFO - blobuploader == 1.2.4 07:55:21 INFO - docopt == 0.6.1 07:55:21 INFO - manifestparser == 1.1 07:55:21 INFO - mozInstall == 1.12 07:55:21 INFO - mozcrash == 0.17 07:55:21 INFO - mozdebug == 0.1 07:55:21 INFO - mozdevice == 0.48 07:55:21 INFO - mozfile == 1.2 07:55:21 INFO - mozhttpd == 0.7 07:55:21 INFO - mozinfo == 0.9 07:55:21 INFO - mozleak == 0.1 07:55:21 INFO - mozlog == 3.2 07:55:21 INFO - moznetwork == 0.27 07:55:21 INFO - mozprocess == 0.22 07:55:21 INFO - mozprofile == 0.28 07:55:21 INFO - mozrunner == 6.11 07:55:21 INFO - mozscreenshot == 0.1 07:55:21 INFO - mozsystemmonitor == 0.3 07:55:21 INFO - moztest == 0.7 07:55:21 INFO - mozversion == 1.4 07:55:21 INFO - psutil == 3.1.1 07:55:21 INFO - requests == 1.2.3 07:55:21 INFO - wsgiref == 0.1.2 07:55:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:55:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:55:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:55:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:21 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 0x101f5fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f65570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3b24ba200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e03d30>, '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 0x101c27db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101dfab20>, '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.BxG5FsD0qR/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.DH41pVV7hp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 07:55:21 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 07:55:21 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 07:55:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BxG5FsD0qR/Render', 07:55:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:55:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:55:21 INFO - 'HOME': '/Users/cltbld', 07:55:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:55:21 INFO - 'LOGNAME': 'cltbld', 07:55:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:21 INFO - 'MOZ_NO_REMOTE': '1', 07:55:21 INFO - 'NO_EM_RESTART': '1', 07:55:21 INFO - 'PAGER': '/bin/cat', 07:55:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:55:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:55:21 INFO - 'PWD': '/builds/slave/test', 07:55:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:55:21 INFO - 'SHELL': '/bin/bash', 07:55:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DH41pVV7hp/Listeners', 07:55:21 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 07:55:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:55:21 INFO - 'USER': 'cltbld', 07:55:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:55:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:55:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:21 INFO - 'XPC_FLAGS': '0x0', 07:55:21 INFO - 'XPC_SERVICE_NAME': '0', 07:55:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:55:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:21 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)) 07:55:21 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)) 07:55:21 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)) 07:55:21 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)) 07:55:21 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)) 07:55:21 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)) 07:55:21 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)) 07:55:21 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)) 07:55:21 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)) 07:55:21 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)) 07:55:21 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)) 07:55:21 INFO - Cleaning up... 07:55:22 INFO - Return code: 0 07:55:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:55:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101f5fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f65570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3b24ba200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e03d30>, '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 0x101c27db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101dfab20>, '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.BxG5FsD0qR/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.DH41pVV7hp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 07:55:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:55:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:55:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BxG5FsD0qR/Render', 07:55:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:55:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:55:22 INFO - 'HOME': '/Users/cltbld', 07:55:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:55:22 INFO - 'LOGNAME': 'cltbld', 07:55:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:22 INFO - 'MOZ_NO_REMOTE': '1', 07:55:22 INFO - 'NO_EM_RESTART': '1', 07:55:22 INFO - 'PAGER': '/bin/cat', 07:55:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:55:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:55:22 INFO - 'PWD': '/builds/slave/test', 07:55:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:55:22 INFO - 'SHELL': '/bin/bash', 07:55:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DH41pVV7hp/Listeners', 07:55:22 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 07:55:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:55:22 INFO - 'USER': 'cltbld', 07:55:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:55:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:55:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:22 INFO - 'XPC_FLAGS': '0x0', 07:55:22 INFO - 'XPC_SERVICE_NAME': '0', 07:55:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:55:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:22 INFO - Downloading/unpacking jsonschema 07:55:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:55:24 INFO - Downloading/unpacking functools32 (from jsonschema) 07:55:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:25 INFO - Downloading functools32-3.2.3-2.tar.gz 07:55:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:55:25 INFO - warning: no files found matching '*.txt' 07:55:25 INFO - no previously-included directories found matching 'build' 07:55:25 INFO - no previously-included directories found matching 'dist' 07:55:25 INFO - no previously-included directories found matching '.git*' 07:55:25 INFO - Installing collected packages: jsonschema, functools32 07:55:25 INFO - Running setup.py install for functools32 07:55:25 INFO - warning: no files found matching '*.txt' 07:55:25 INFO - no previously-included directories found matching 'build' 07:55:25 INFO - no previously-included directories found matching 'dist' 07:55:25 INFO - no previously-included directories found matching '.git*' 07:55:25 INFO - Successfully installed jsonschema functools32 07:55:25 INFO - Cleaning up... 07:55:25 INFO - Return code: 0 07:55:25 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:55:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:55:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:55:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101f5fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f65570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3b24ba200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e03d30>, '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 0x101c27db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101dfab20>, '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.BxG5FsD0qR/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.DH41pVV7hp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 07:55:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:55:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:55:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BxG5FsD0qR/Render', 07:55:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:55:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:55:25 INFO - 'HOME': '/Users/cltbld', 07:55:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:55:25 INFO - 'LOGNAME': 'cltbld', 07:55:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:25 INFO - 'MOZ_NO_REMOTE': '1', 07:55:25 INFO - 'NO_EM_RESTART': '1', 07:55:25 INFO - 'PAGER': '/bin/cat', 07:55:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:55:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:55:25 INFO - 'PWD': '/builds/slave/test', 07:55:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:55:25 INFO - 'SHELL': '/bin/bash', 07:55:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DH41pVV7hp/Listeners', 07:55:25 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 07:55:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:55:25 INFO - 'USER': 'cltbld', 07:55:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:55:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:55:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:25 INFO - 'XPC_FLAGS': '0x0', 07:55:25 INFO - 'XPC_SERVICE_NAME': '0', 07:55:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:55:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:25 INFO - Downloading/unpacking flake8 07:55: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 07:55: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 07:55: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 07:55: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 07:55: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 07:55: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 07:55:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:55:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:55:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:55:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:55:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:55:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:55:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:55:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:55:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:55:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:55:29 INFO - no previously-included directories found matching 'docs/_build' 07:55:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:55:29 INFO - Running setup.py install for pep8 07:55:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:55:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:55:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:55:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:55:29 INFO - no previously-included directories found matching 'docs/_build' 07:55:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:55:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:55:29 INFO - Cleaning up... 07:55:29 INFO - Return code: 0 07:55:29 INFO - Running post-action listener: _resource_record_post_action 07:55:29 INFO - Running post-action listener: _start_resource_monitoring 07:55:29 INFO - Starting resource monitoring. 07:55:29 INFO - ##### 07:55:29 INFO - ##### Finished create-virtualenv step (success) 07:55:29 INFO - ##### 07:55:29 INFO - ##### 07:55:29 INFO - ##### Running install step. 07:55:29 INFO - ##### 07:55:29 INFO - Running pre-action listener: _resource_record_pre_action 07:55:29 INFO - Running main action method: install 07:55:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:55:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:55:29 INFO - Reading from file tmpfile_stdout 07:55:29 INFO - Detecting whether we're running mozinstall >=1.0... 07:55:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:55:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:55:30 INFO - Reading from file tmpfile_stdout 07:55:30 INFO - Output received: 07:55:30 INFO - Usage: mozinstall [options] installer 07:55:30 INFO - Options: 07:55:30 INFO - -h, --help show this help message and exit 07:55:30 INFO - -d DEST, --destination=DEST 07:55:30 INFO - Directory to install application into. [default: 07:55:30 INFO - "/builds/slave/test"] 07:55:30 INFO - --app=APP Application being installed. [default: firefox] 07:55:30 INFO - mkdir: /builds/slave/test/build/application 07:55:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:55:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 07:56:04 INFO - Reading from file tmpfile_stdout 07:56:04 INFO - Output received: 07:56:04 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:56:04 INFO - Running post-action listener: _resource_record_post_action 07:56:04 INFO - ##### 07:56:04 INFO - ##### Finished install step (success) 07:56:04 INFO - ##### 07:56:04 INFO - ##### 07:56:04 INFO - ##### Running run-tests step. 07:56:04 INFO - ##### 07:56:04 INFO - Running pre-action listener: _resource_record_pre_action 07:56:04 INFO - Running main action method: run_tests 07:56:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:56:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:56:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:56:04 INFO - 2016-05-27 07:56:04.174 screenresolution[1648:8701] starting screenresolution argv=screenresolution get 07:56:04 INFO - 2016-05-27 07:56:04.176 screenresolution[1648:8701] Display 0: 1600x1200x32@60 07:56:04 INFO - 2016-05-27 07:56:04.183 screenresolution[1649:8703] starting screenresolution argv=screenresolution list 07:56:04 INFO - Available Modes on Display 0 07:56:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:56:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:56:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:56:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:56:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:56:04 INFO - Intel Iris: 07:56:04 INFO - Chipset Model: Intel Iris 07:56:04 INFO - Type: GPU 07:56:04 INFO - Bus: Built-In 07:56:04 INFO - VRAM (Dynamic, Max): 1536 MB 07:56:04 INFO - Vendor: Intel (0x8086) 07:56:04 INFO - Device ID: 0x0a2e 07:56:04 INFO - Revision ID: 0x0009 07:56:04 INFO - Displays: 07:56:04 INFO - Display: 07:56:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:56:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:56:04 INFO - Display Serial Number: 1600x1200 60 07:56:04 INFO - Main Display: Yes 07:56:04 INFO - Mirror: Off 07:56:04 INFO - Online: Yes 07:56:04 INFO - Rotation: Supported 07:56:04 INFO - Return code: 0 07:56:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:56:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:56:04 INFO - Python 2.7.3 07:56:04 INFO - Return code: 0 07:56:04 INFO - grabbing minidump binary from tooltool 07:56:04 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')]} 07:56:04 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e03d30>, '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 0x101c27db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101dfab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:56:04 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 07:56:04 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 07:56:04 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:56:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:56:04 INFO - Return code: 0 07:56:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:56:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:56:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:56:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:56:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:56:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:56:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:56:05 INFO - Return code: 0 07:56:05 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-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BMi-wQBRQge783nRqNABZw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0344', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:56:05 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-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BMi-wQBRQge783nRqNABZw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0344 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:56:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BxG5FsD0qR/Render', 07:56:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:56:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:56:05 INFO - 'HOME': '/Users/cltbld', 07:56:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:56:05 INFO - 'LOGNAME': 'cltbld', 07:56:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:56:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:56:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:05 INFO - 'MOZ_NO_REMOTE': '1', 07:56:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:56:05 INFO - 'NO_EM_RESTART': '1', 07:56:05 INFO - 'PAGER': '/bin/cat', 07:56:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:56:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:05 INFO - 'PWD': '/builds/slave/test', 07:56:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:56:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:56:05 INFO - 'SHELL': '/bin/bash', 07:56:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DH41pVV7hp/Listeners', 07:56:05 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 07:56:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:56:05 INFO - 'USER': 'cltbld', 07:56:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:56:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:56:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:05 INFO - 'XPC_FLAGS': '0x0', 07:56:05 INFO - 'XPC_SERVICE_NAME': '0', 07:56:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:56:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BMi-wQBRQge783nRqNABZw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0344', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:56:06 INFO - mozversion application_buildid: 20160527053644 07:56:06 INFO - mozversion application_changeset: df3281895c93b96241347e8c6a699256bcb3970c 07:56:06 INFO - mozversion application_display_name: Nightly 07:56:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:56:06 INFO - mozversion application_name: Firefox 07:56:06 INFO - mozversion application_remotingname: firefox 07:56:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:56:06 INFO - mozversion application_vendor: Mozilla 07:56:06 INFO - mozversion application_version: 49.0a1 07:56:06 INFO - mozversion platform_buildid: 20160527053644 07:56:06 INFO - mozversion platform_changeset: df3281895c93b96241347e8c6a699256bcb3970c 07:56:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:56:06 INFO - mozversion platform_version: 49.0a1 07:56:06 INFO - using testdate: 1464360966 07:56:06 INFO - actual date: 1464360966 07:56:06 INFO - starting webserver on 'localhost:49276' 07:56:06 INFO - SUITE-START | Running 2 tests 07:56:06 INFO - TEST-START | dromaeo_css 07:56:06 INFO - operating with platform_type : mac_ 07:56:06 INFO - Initialising browser for dromaeo_css test... 07:56:06 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/tmpWtPukH/profile http://localhost:49276/getInfo.html) 07:56:09 INFO - PROCESS | 1667 | __metrics Screen width/height:1600/1200 07:56:09 INFO - PROCESS | 1667 | colorDepth:24 07:56:09 INFO - PROCESS | 1667 | Browser inner width/height: 1024/689 07:56:09 INFO - PROCESS | 1667 | __metrics 07:56:09 ERROR - PROCESS | 1667 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 07:56:09 INFO - TEST-INFO | 1667: exit 0 07:56:09 INFO - Browser initialized. 07:56:09 INFO - Running cycle 1/1 for dromaeo_css test... 07:56:09 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/tmpWtPukH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:56:21 INFO - PROCESS | 1671 | RSS: Main: 252428288 07:56:21 INFO - PROCESS | 1671 | 07:57:11 INFO - PROCESS | 1671 | 1464361031484 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] 07:59:21 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 07:59:23 INFO - PROCESS | 1671 | RSS: Main: 264589312 07:59:23 INFO - PROCESS | 1671 | 08:02:25 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 08:02:26 INFO - PROCESS | 1671 | RSS: Main: 276058112 08:02:26 INFO - PROCESS | 1671 | 08:05:28 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 08:05:28 INFO - PROCESS | 1671 | RSS: Main: 278134784 08:05:28 INFO - PROCESS | 1671 | 08:08:30 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 08:08:31 INFO - PROCESS | 1671 | RSS: Main: 279511040 08:08:31 INFO - PROCESS | 1671 | 08:11:33 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 08:11:34 INFO - PROCESS | 1671 | RSS: Main: 283242496 08:11:34 INFO - PROCESS | 1671 | 08:14:36 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 08:14:37 INFO - PROCESS | 1671 | RSS: Main: 283238400 08:14:37 INFO - PROCESS | 1671 | 08:14:37 INFO - PROCESS | 1671 | __start_tp_report 08:14:37 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 08:14:37 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 08:14:37 INFO - PROCESS | 1671 | |i|pagename|runs| 08:14:37 INFO - PROCESS | 1671 | |0;dojo.html;3211.7912335698184;3541.256336169404;3543.5747710274773;3566.9477504136275;3589.0489020409595;5815.883682326356;5871.354151043387;5937.436147892693;5947.821565353041;6039.72821223045;5893.145493903392;5920.378360272174;5961.61249518781;6014.368491308404;6046.606970546923;5342.065138600739;5373.355197376321;5477.67133971961;5480.424555421683;5584.6090773645865;29.0814676602447;5294.867628309304;5371.435999220084;5438.320209973754;5439.755211015494;5417.6478528895495;5438.592105592096;5452.073147564924;5474.151506516477;5479.0959491683825;5459.099248624012;5459.754311056012;5463.344398672145;5492.12529813327;5514.145307477347;5314.309139811839;5329.760160792774;5335.226392173152;5385.973070134624;5408.729563521848;5745.368009518949;5819.709014549256;5863.736131874076;5885.087811389199;5925.377835327315;6179;6269.780557680459;6322;6327.209098862642;6333.334999825044;6295.811125666238;6359.268684101341;6365.554411191219;6430.1319321891415;6432.51756118293;6147.016477363601;6162;6167.136600875836;6168.87662246757;6171.444569988723;6262.436380725757;6337.4613157882095;6559.344065593403;6564.048213009087;6566.6388348641285;6188.752449902044;6193.318734939153;6205.348438413992;6229.719662615194;6265.216847894013;5050.72221027847;6348.587341822767;6360.204974378203;6397.008463688136;6404.935950640527;5165.509276618715;6214.9689251553455;6233.906491402633;6281.183446151971;6315.179026726588;6261.405166509266;6271.216097987752;6288.025356069817;6292.087647291117;6305.337939516285;5117.385913690381;5126.8974620508125;5129.9743501283;5136.614753893473;5139.948600514022;4449.555044495589;4497.370368148462;4499.257622492252;4619.6073333766335;4669.995950870579;4688.484266730657;6008.279006519246;6054.788082417094;6058.394160583995;6106.460667179974;6346.746130154742;6370.936290637034;6389.6805159741825;6392.26488953767;6394.424501794861;5941.287045554474;6049.485793707584;6072.05883088122;6102.572819902653;6111.144439778434;5085.830259040441;5274.235235890851;5562.193481945176;5583.162525621189;5593.8321850344555;6369.808905732835;6613.834654133589;6615;6628.171478565179;6637.1703537057865;6263.937360626518;6300.369963003663;6316.242050953915;6410.038494225717;6423.550351475352;6591.472682185509;6606.8017959461295;6609.4712423007;6631.701573429304;6643.900341494785;6173.84565385869;6194.752209911553;6315.810525684236;6318.4313411793155;6348.9047664286;6268.655223962726;6338.397852204033;6398.584092034003;6425.58233714807;6426.325235850169;6031.577789554689;6180.845478863064;6223.906641400473;6239.313675495601;6257.186565746424;6138.480361557057;6168.660723660242;6217.626942383471;6220.222472190976;6237.220347456568;6036.336003039574;6165.4451099399475;6216.067589861557;6218.253809542884;6239.251289845248;6229.875402492015;6234.594751341148;6243.188385509855;6246.3441338660605;6248.156498872776;6096.2243283589;6105.786297479567;6135.386461353829;6162.322144564184;6195.566310358232 08:14:37 INFO - PROCESS | 1671 | |1;ext.html;497.4726789603021;508.80411041748926;509.5770510476305;549.8432946610217;575.4763165519373;39150.80424597877;41545.584544154546;41553.37669934954;41557.376639350434;41667.16665666689;42106.36840447396;42854.7857260714;42912.78543607277;42971.570284297144;42982.785086074604;9437.386569872971;9662.32363734539;9675.080867317629;9685.612575497007;9703.90296097037;9563.856542151838;9564.66094746736;9643.469609171492;9659.903400966006;9686.32195746298;8165.591720413956;9659.517024148765;9671.129598336149;9682.709518714415;9683.806323873518;8280.83438331236;9629.855552166724;9632.614695412176;9644.08381203788;9662.75843103921;9526.285528585384;9675.806483870283;9703.17523010545;9709.271804614682;9710.61157553697;39897.40153897694;40078.39882401766;40328.39507407391;40451.19097618031;40600.796996015124;2781.694013658496;3168.588083549147;3294.456414691573;3459.70261152068;3560.1989552350774;22619.321420357417;30266.54600180999;30361.392772144434;30982.845085774654;31015.379692406026;2905.721482547672;2978;3073.3853229354218;3122.81263124211;3128.671489493593;387840;426590.6011409831;441095;475581.24418755714;477573.6121319406;33377.16557086044;34832;34905.778297759454;35136.47295290573;35145.82427087848;30330.393392132035;31109.844450778055;35725.64274357275;35820;36539.817300913324;16838.326466941184;17197.140142993052;17205;17216.827831721774;17274.309027639007;12885.613431597067;12940.15888967214;13074.411651475706;13175.67060823468;13392.129511581716;19100.662953593113;19180.808191918182;20248.898755506423;20454;20536.486587835127;7035.8241043973285;7129.754127449837;7827.099883513355;8482.049128700433;8531.95734021326;805.3637626275294;832.7876391520244;1158.212415557429;1172.8827117288204;1177.181858608259;29689.703102969124;31149.688503115132;31725.841370792998;31776;31943.881964131146;1007.4559737741685;1061.4109169411051;1144.8511693479795;1168.6727716239466;1234.8703386144505;16131.790115741367;16179.514614561582;16284.83715162857;16510.587235319214;16536;662889;669742;670209;671359;671505;48423.75788121107;49371.75314123478;60122.39877601168;60196.097058544154;60290.69854650699;1391.6938273579797;1433.62725691321;1446.2190417174818;1448.1455940994863;1448.3482432905234;30443.695563044974;30464.867459277637;30721.078367649006;30809.69190308158;31214.21964450907;51998;52025.21962170495;52541.7372913133;52775.20837187522;52836.73581632067;514026;515375;515988;517150;520225;27605.309867252676;27954.440911182068;28038.719612803612;28712.282192945342;28810.703518341306;48952.51047489479;49428.50571494239;49705.50294497009;49953;50496.99006019933;39179.60820391874;40826;40912;41244.38133428061;41426.171476570904;40302.99242518961;40407.59592404038;40614;40985.590144098176;41215.79392103021;38127.42808857814;38671.22657546889;39602.40596390999;39710;39814.2037159261;31228;36453;36942.44586331261;37333.43999840059;37375.62624373721;21027.369178924044;26020.479590407707;26313.73686263113;26351.604725928744;26801.927922883646 08:14:37 INFO - PROCESS | 1671 | |2;jquery.html;301.5506894726857;318.39504940612846;364.75014614988726;371.11859334081555;401.4660501532961;14015.018948673584;20044.89977550112;20855.95720213989;20870.68693969588;20897.26859559916;16940.83059169408;19691.31080412186;19901.800981990174;20729.792702072973;20787.792122078776;4989.57588604969;5608.775648974036;5836.241288632493;5861.941380586182;5867.76528938842;4346.348047792825;5737.082066869301;5753.769849206027;5814.24414826072;5822.912656310159;5633.7183140843;5781.421857814227;5997.760089596432;6408.551401401881;6411.390917862819;5397.163439666858;6390.6804659767295;6431.035344698286;6435.6138631682015;6584.374484423972;5782.248307720011;5820.272465941757;5839.970800146015;5868.8239352819055;5868.882622347529;13173.538926137539;17647.5588110297;23438;24716.382090447703;24731.87634061836;2168.620491413996;2199.373178644095;2260.175036111824;2264.218844498662;2518.26970178648;9158.587863546156;9185.035571265054;9917.603295868157;9932.205423566098;10050.59797608102;1807.6203997160612;1843.5759775251634;1901.4390754727388;1917.7027560728109;1953.3749200255925;108626;113792.43103784428;117642.82357176405;126009.36995315057;126755;10130.645427410005;10359.533820978075;11414.486348114355;11468.566429196351;11500.309981401142;14129.293535323193;14322.85677143236;14392;14423.78364324536;14430.711385772225;8471;8538.487690738575;8585.742427727178;8630.95684521586;8661.177188167114;7033.366996970297;8564.871526927102;8573.356998225034;8669.133086691281;8679;4456.86629401112;4537.523560026149;4554.282433410693;4558.202314594999;4626.514216007271;1778.9822101779075;1897.8007309232332;1920.6363481927708;1932.584494333697;1942.4852414110271;789.759123467348;849.9320054395633;865.0182043380809;993.8360170571775;1018.0989824005808;10710.196735244888;10815.513301901276;10880.72798180036;11409.315441073562;11564.537418503334;419.5804195804196;438.9978050109729;442.6149250152388;446.3015380928836;448.33646203618827;6000.369961154016;6065.514758819284;6127.571070025056;6145.754169833246;6146;612210;618667;619917;622689;624175.8791206105;98229;120703;122589.38705306416;125001;127108;457.9610733087725;461.1261659155881;462.09660114476117;463.4716423277466;463.9141758774638;10931;11016.283941543774;11163.665090047312;11229.71925701864;11307.151963602928;47487.86304616232;52248.69378265574;52343.73828130835;52714.73642631762;52999.73500132629;72361.6381918087;73621.26378736144;74730.25269747233;75157;75570.62214688891;11356.659300221007;11496.367699776592;11745.647630571097;11805.468753905923;12013.399330033288;10421.895781042092;12715.237085774883;12837.679058023625;12914.870851291367;13049.608511744664;10987.121030317716;11007.779844403227;11278;11295.830562541403;11304.547818087185;9043.638254469748;11006.339619622848;11175.497102630563;11280.210385272952;11286.266392684778;11369.772604548029;11550.306981581132;11552.278313481103;11662.475188616701;11682.12384071181;11707.180497365103;11818.995385391994;11925.940370298093;11932.761344772882;11945.2832830027;11356.716082098013;11358.432078396212;11411.486483108114;11423.657290281304;11463.942680286878 08:14:37 INFO - PROCESS | 1671 | |3;mootools.html;1502.2713983717895;1560.0093940347876;1764.647070585883;1889.3198448558517;1898.743669604603;8090.393220508471;8331.250187483125;8784;9342.953285233565;9364.812703745922;7405.629718514067;8950.23922966547;9130.680426185085;9132.269418446525;9169.266458683305;2400.2319257837457;2428.7935525480357;2429.465517586137;2432.0636554926305;2446.449548851512;2022.2416593777334;2396.2451827674313;2432.622943443769;2433.707955045397;2438.829281950264;1984.2856571634272;2376.0495801679294;2384.7853693167613;2389.5340408620327;2399.664047033417;2315.108683156997;2350.553394854972;2370.1941339944415;2373.762623737621;2397.832151749378;2365.6451532270125;2379.3575734551746;2382.3805810489225;2386.0813586769045;2392.246442370648;7783.805404864867;9085.636574537011;9101;9143.817123657556;9149.81700365989;5445.727713614304;5561.082421400464;5567.248421463091;5575.553955683536;5589.720513974285;3694;3715.10837399025;3733.0028434787528;3780.206156707095;3802.99220706513;1068.3803394031443;1098.9505472253768;1123.915706322021;1124.235519846504;1765.920533575992;11957.222780519238;12063.638090857288;12186.695332616668;12187.573434929824;12233.694157646041;4575.908481830411;4686.531346865286;4703.3885594872445;4768.976155119202;4772.546608072227;9422.293328000427;9459;9478.431294122374;9488.905110948941;9498.09768072032;5221.869453263623;5234.110201265794;5287.894242115136;5381.838544843661;5425.077736784756;4484.260097084009;4832.4684284728655;4986.626003049713;5002.724850133205;5021.949780502148;3825.1967086911504;3863.092173339263;3935.704822138351;3950.249452603996;4005.2990726623307;1189.6787867275787;1190.2441949362044;1192.1535709646248;1197.479096592985;1200.9579664711694;702.7575486457164;753.3408267765705;812.4150611559668;849.524266410812;850.80461950959;5216.530512253916;6103.481204097613;6122.479589234876;6137.508999280047;6191.752329906753;925.5742358515158;932.7780607404322;942.0438255171007;945.9716208513755;973.5862258540092;4014.558398576154;4087.141700242982;4146.108586653884;4156.605122513417;4166.104287578185;10456.215783816244;10953;11034.724131896606;11050.502727377287;11076.446177691083;8477.872831907527;10981.901809819114;10982;10986.176036797113;11065.50205240766;7997.280244777998;8315.04376996641;8468.534230617375;8469.364797640079;8490.830183396298;5171.3277273954145;5790.9420905792085;6056.939430605637;6106.9083963739695;6108;10187.185025198114;10369.325993810378;10397.168226541708;10404.167666586503;10420.791584168426;9000.81998360016;10412.271141020055;10461.163106951273;10620.15038796879;10652.254342195973;6672.499562532732;7172.49792514519;7212.4951253411755;7228.710851565878;7280.526765760209;7277.38142257914;8662.263707584674;8727.389082764146;8757;8760.817289665814;6379.585326953733;7417.517861338995;7817.257360550739;7832.0601527817025;7866.842663146819;7310.8903366448485;7514.248575142442;7530.021097257321;7634.618269086634;7643.4267429941865;7104.040954471287;7111.359977602041;7148.392386647193;7180.748673796392;7197.604131772803;4257.659387249075;4802.727277271456;4973.557668276304;5158.277841102174;5181.740912954262;5120.334356533627;5133.820316288912;5136.229565565195;5220.817271395483;5264.86837829042 08:14:37 INFO - PROCESS | 1671 | |4;prototype.html;302.7941000119919;310.3173019357414;315.8736505397841;321.5723088292571;323.3887951771153;5006.774695138718;5471.261379713737;5599.972000140004;5859.121131830228;5865.941340586593;4432.492952396185;5492.038893193695;5657.207990881269;5667.943320566793;5686.147077938312;3466.341395134929;3649.562052553684;3847.7498962567342;4171.3742938559235;4350.390945267649;4036.5871944819223;4216.746995180284;4287.942946289277;4371.519132895379;4395.450568678915;3513.7013353864954;4059.147579008412;4270.807813648394;4316.762578058206;4323.718958267718;4003.4395184674167;4186.099988502471;4314.352847072949;4350.543192964757;4353.28170851809;3311.337732453519;3348.179695974502;3415.8121303328307;3473.392156372625;3616.222512159898;5062.519060689228;5423.132298832207;5447.373552041487;5452.4274951129955;5453.609329620961;3669.412893936957;4094.324436467979;4439.933400998988;4524.11779702958;4793.784279707422;4562;5410.513053825135;5653.8586535336535;5698.544116470714;5939.67331796751;3314.171457135716;3332.900012999614;3347.96652033479;3957.357696555926;3970.9007274818073;4919.532644398776;6088.903997280488;6275.372462753734;6299.968500157515;6353.188087147721;3471.930561388758;3816.8091595420674;4040.3939409088284;4044.0900797320955;4053.9797301013305;3544.113971507123;3914.4715463412645;4034.919301613951;4102.200070986189;4105.876823695294;4113.4035564843525;4281.935770963438;4828.806847726122;4834;4852.8544143675745;4782.497837727058;5373.892522149535;5848.058032491427;6039.667818270037;6070.361002529292;1372.9771320366192;1396.3871728154;1400.4608225833128;1413.590058882933;1422.4025909118195;716.7240612364277;745.4595418321674;844.3118858130604;849.3078141314809;850.9361797865184;3816.9618303816605;4069;4692.319613656069;4729.597984171384;4838;4448.510663826976;4631;4718.41019872516;4965.553100220925;5255.633535280855;4278.101598664253;4489.73061616304;4625.889786451227;4688.077888065876;4838.588719958772;2894.2908987297824;2921.8539073046686;2946.583801282927;3292.3086151907887;3316.1875340541724;6472.935270647327;6475.417212450902;6524.543281970216;6525.836854078686;6531.542792004514;5680.7727690892725;5855.887381397521;5864.501517370986;5865.94134058654;6052.66710330936;5797.623154495029;6410.525579116736;6436.195475565554;6455.322191169954;6474.1907261592305;4964.799571041191;5341.732913354394;5397.244385785914;6084.69576521181;6262.091996660368;4959.876003099951;5404.8108316208745;6117.543587872838;6125.6110117053495;6160.182746090004;6401.807945761635;6441.903371449338;6482.740690372332;6507.089007539043;6540.117084193573;3492.825358732104;3805.923881522299;3813.951163430079;4042.838286468626;4045.3527435610163;5057.544820966131;5300.655457395257;5895.4399332063385;6079.817605471843;6162.383761623802;5185.585153187812;5208.8437346879655;5512.641678290898;5609.298837645294;6062.151298818081;5518.448155184449;5606.906653202586;5930.7924222652;5948.910766338422;5975.521958243417;5760.8271751847515;5808.82573522795;5829.387914268941;5876.41235876409;5901.232839730807;5250.65870718402;5608.523275521627;5844.357120716632;5976.19321391624;5992.400759923973;5569.275994120739;5870.119482077723;5870.442307980735;5895.526118470382;5946.345901950868 08:14:37 INFO - PROCESS | 1671 | |5;yui.html;670.9630970296631;687.3126873126873;692.1417442371461;750.0174771049925;820.33552822214;14049.508267210636;14698.338574764135;14828;14831.258437078157;14874.925625371858;11917.463714132864;14045.227512486834;14079.57761267161;14087.788683169761;14119.223442710647;707.0243064570885;870.960806763694;892.9687460938868;912.1835956818643;917.1699611851285;898.9820203595924;901.33301356996;905.7146998695423;908.5638893331205;909.5679552212712;964.8986856380084;967.0377973915963;967.4678926590383;969.2197780786464;969.5830792759111;795.1650766694947;952.6856137474617;956.063058202958;960.812641534901;964.5804075227298;592.3927973826862;708.9822754431129;710.431654676262;710.70860947012;712.0458585495461;14415.207163605997;14785.038972466755;14794.630134246623;14933.402663893432;14987.175705336202;14388.92805535976;14423.423063077464;14452.783208251885;14493.275336233146;14493.420263189566;10292.382457052601;11071.446427678584;11237.26957747752;11270.887291127066;11464.140189485823;3314.751393645462;3809.676177524914;3863.652271295597;3870.3033453978273;3898.2788184186015;82351;85587;85847.57076214641;86401.56799216027;86885;10942.617008404668;11052.226344155832;11150.21948463616;11278.81572434899;11543.76912461763;22478.775212247994;22481;22509;22512.774872251397;22524.54950900973;7887.921120788834;8003.439759216799;8132.2680958714;8338.416310858303;8352.582370881431;4407.6914615976575;4465.531677365313;4494.685372023927;4506.1213063452315;4519.231730605805;3482.077249528877;3545.4859045438784;3557.1285035166034;3602.2075143468396;3603.1892824114366;594.46201187925;658.9472842172614;671.6876652356677;673.9056532085511;674.652553934724;604.9667268300286;650.5446187668651;695.7495301691387;707.9663691011078;724.9093863267092;9389.483578403117;9528.714138575853;9701.854472182922;9718.75703107428;9822.459764712867;542.6581253810075;603.5081408652022;619.4301242856583;687.1792831854902;691.5021184746975;4064.248114098901;4271.551487093872;4533.977330113395;4618.330342100377;4699.271612900006;90105;90613.09386906179;91128;91980.54009730043;92564.53717731369;70950;80330;80902.59548702219;83666;84670;51776.74111629418;69215.92352229341;76951;77127.61436192783;77305;7440.962795185989;8656.523891186045;8690.478571285743;9453.952730236304;9569.760755981157;36187.37156828002;43912.560874390845;44726.77636611796;48107.75946120247;48205.276920845514;58387.70806146112;58578.24265272049;65042.024369633546;66415.66792166009;67360.32639673736;12778.744425111632;12851.678708032374;12938.330114100181;13023.153495022792;13476.249733518898;14420.567382978528;14434.927825360806;14478;14577.198254095701;14677.706445871236;12904.677383065498;13401.86598134006;13476.393562289524;13725.725485490433;14019;13200.14199077057;13303.534376296782;13448.327583620585;13496.491271882962;13792.586222413343;11788.528458861549;12123.75752484963;12953.611391658265;13153.94768418505;13671.17972921628;10477.790444191225;10914.781704365709;11106.672791547613;11131.220814542905;11539.192256542297;8256.587170641324;10557.366558006237;11107.94446027797;11158;11371.090312775124 08:14:37 INFO - PROCESS | 1671 | __end_tp_report 08:14:37 INFO - PROCESS | 1671 | __start_cc_report 08:14:37 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,411 08:14:37 INFO - PROCESS | 1671 | __end_cc_report 08:14:37 INFO - PROCESS | 1671 | __startTimestamp1464362077032__endTimestamp 08:14:37 INFO - PROCESS | 1671 | 08:14:37 INFO - PROCESS | 1671 | ------- Summary: start ------- 08:14:37 INFO - PROCESS | 1671 | Number of tests: 6 08:14:37 INFO - PROCESS | 1671 | 08:14:37 INFO - PROCESS | 1671 | [#0] dojo.html Cycles:165 Average:5868.01 Median:6167.14 stddev:793.05 (12.9%) stddev-sans-first:767.62 08:14:37 INFO - PROCESS | 1671 | Values: 3211.8 3541.3 3543.6 3566.9 3589.0 5815.9 5871.4 5937.4 5947.8 6039.7 5893.1 5920.4 5961.6 6014.4 6046.6 5342.1 5373.4 5477.7 5480.4 5584.6 29.1 5294.9 5371.4 5438.3 5439.8 5417.6 5438.6 5452.1 5474.2 5479.1 5459.1 5459.8 5463.3 5492.1 5514.1 5314.3 5329.8 5335.2 5386.0 5408.7 5745.4 5819.7 5863.7 5885.1 5925.4 6179.0 6269.8 6322.0 6327.2 6333.3 6295.8 6359.3 6365.6 6430.1 6432.5 6147.0 6162.0 6167.1 6168.9 6171.4 6262.4 6337.5 6559.3 6564.0 6566.6 6188.8 6193.3 6205.3 6229.7 6265.2 5050.7 6348.6 6360.2 6397.0 6404.9 5165.5 6215.0 6233.9 6281.2 6315.2 6261.4 6271.2 6288.0 6292.1 6305.3 5117.4 5126.9 5130.0 5136.6 5139.9 4449.6 4497.4 4499.3 4619.6 4670.0 4688.5 6008.3 6054.8 6058.4 6106.5 6346.7 6370.9 6389.7 6392.3 6394.4 5941.3 6049.5 6072.1 6102.6 6111.1 5085.8 5274.2 5562.2 5583.2 5593.8 6369.8 6613.8 6615.0 6628.2 6637.2 6263.9 6300.4 6316.2 6410.0 6423.6 6591.5 6606.8 6609.5 6631.7 6643.9 6173.8 6194.8 6315.8 6318.4 6348.9 6268.7 6338.4 6398.6 6425.6 6426.3 6031.6 6180.8 6223.9 6239.3 6257.2 6138.5 6168.7 6217.6 6220.2 6237.2 6036.3 6165.4 6216.1 6218.3 6239.3 6229.9 6234.6 6243.2 6246.3 6248.2 6096.2 6105.8 6135.4 6162.3 6195.6 08:14:37 INFO - PROCESS | 1671 | 08:14:37 INFO - PROCESS | 1671 | [#1] ext.html Cycles:180 Average:66982.10 Median:39855.80 stddev:147341.44 (369.7%) stddev-sans-first:147670.21 08:14:37 INFO - PROCESS | 1671 | Values: 497.5 508.8 509.6 549.8 575.5 39150.8 41545.6 41553.4 41557.4 41667.2 42106.4 42854.8 42912.8 42971.6 42982.8 9437.4 9662.3 9675.1 9685.6 9703.9 9563.9 9564.7 9643.5 9659.9 9686.3 8165.6 9659.5 9671.1 9682.7 9683.8 8280.8 9629.9 9632.6 9644.1 9662.8 9526.3 9675.8 9703.2 9709.3 9710.6 39897.4 40078.4 40328.4 40451.2 40600.8 2781.7 3168.6 3294.5 3459.7 3560.2 22619.3 30266.5 30361.4 30982.8 31015.4 2905.7 2978.0 3073.4 3122.8 3128.7 387840.0 426590.6 441095.0 475581.2 477573.6 33377.2 34832.0 34905.8 35136.5 35145.8 30330.4 31109.8 35725.6 35820.0 36539.8 16838.3 17197.1 17205.0 17216.8 17274.3 12885.6 12940.2 13074.4 13175.7 13392.1 19100.7 19180.8 20248.9 20454.0 20536.5 7035.8 7129.8 7827.1 8482.0 8532.0 805.4 832.8 1158.2 1172.9 1177.2 29689.7 31149.7 31725.8 31776.0 31943.9 1007.5 1061.4 1144.9 1168.7 1234.9 16131.8 16179.5 16284.8 16510.6 16536.0 662889.0 669742.0 670209.0 671359.0 671505.0 48423.8 49371.8 60122.4 60196.1 60290.7 1391.7 1433.6 1446.2 1448.1 1448.3 30443.7 30464.9 30721.1 30809.7 31214.2 51998.0 52025.2 52541.7 52775.2 52836.7 514026.0 515375.0 515988.0 517150.0 520225.0 27605.3 27954.4 28038.7 28712.3 28810.7 48952.5 49428.5 49705.5 49953.0 50497.0 39179.6 40826.0 40912.0 41244.4 41426.2 40303.0 40407.6 40614.0 40985.6 41215.8 38127.4 38671.2 39602.4 39710.0 39814.2 31228.0 36453.0 36942.4 37333.4 37375.6 21027.4 26020.5 26313.7 26351.6 26801.9 08:14:37 INFO - PROCESS | 1671 | 08:14:37 INFO - PROCESS | 1671 | [#2] jquery.html Cycles:180 Average:34593.46 Median:12851.11 stddev:103089.08 (802.2%) stddev-sans-first:103346.11 08:14:37 INFO - PROCESS | 1671 | Values: 301.6 318.4 364.8 371.1 401.5 14015.0 20044.9 20856.0 20870.7 20897.3 16940.8 19691.3 19901.8 20729.8 20787.8 4989.6 5608.8 5836.2 5861.9 5867.8 4346.3 5737.1 5753.8 5814.2 5822.9 5633.7 5781.4 5997.8 6408.6 6411.4 5397.2 6390.7 6431.0 6435.6 6584.4 5782.2 5820.3 5840.0 5868.8 5868.9 13173.5 17647.6 23438.0 24716.4 24731.9 2168.6 2199.4 2260.2 2264.2 2518.3 9158.6 9185.0 9917.6 9932.2 10050.6 1807.6 1843.6 1901.4 1917.7 1953.4 108626.0 113792.4 117642.8 126009.4 126755.0 10130.6 10359.5 11414.5 11468.6 11500.3 14129.3 14322.9 14392.0 14423.8 14430.7 8471.0 8538.5 8585.7 8631.0 8661.2 7033.4 8564.9 8573.4 8669.1 8679.0 4456.9 4537.5 4554.3 4558.2 4626.5 1779.0 1897.8 1920.6 1932.6 1942.5 789.8 849.9 865.0 993.8 1018.1 10710.2 10815.5 10880.7 11409.3 11564.5 419.6 439.0 442.6 446.3 448.3 6000.4 6065.5 6127.6 6145.8 6146.0 612210.0 618667.0 619917.0 622689.0 624175.9 98229.0 120703.0 122589.4 125001.0 127108.0 458.0 461.1 462.1 463.5 463.9 10931.0 11016.3 11163.7 11229.7 11307.2 47487.9 52248.7 52343.7 52714.7 52999.7 72361.6 73621.3 74730.3 75157.0 75570.6 11356.7 11496.4 11745.6 11805.5 12013.4 10421.9 12715.2 12837.7 12914.9 13049.6 10987.1 11007.8 11278.0 11295.8 11304.5 9043.6 11006.3 11175.5 11280.2 11286.3 11369.8 11550.3 11552.3 11662.5 11682.1 11707.2 11819.0 11925.9 11932.8 11945.3 11356.7 11358.4 11411.5 11423.7 11463.9 08:14:37 INFO - PROCESS | 1671 | 08:14:37 INFO - PROCESS | 1671 | [#3] mootools.html Cycles:180 Average:5771.85 Median:5071.14 stddev:3241.73 (63.9%) stddev-sans-first:3234.95 08:14:37 INFO - PROCESS | 1671 | Values: 1502.3 1560.0 1764.6 1889.3 1898.7 8090.4 8331.3 8784.0 9343.0 9364.8 7405.6 8950.2 9130.7 9132.3 9169.3 2400.2 2428.8 2429.5 2432.1 2446.4 2022.2 2396.2 2432.6 2433.7 2438.8 1984.3 2376.0 2384.8 2389.5 2399.7 2315.1 2350.6 2370.2 2373.8 2397.8 2365.6 2379.4 2382.4 2386.1 2392.2 7783.8 9085.6 9101.0 9143.8 9149.8 5445.7 5561.1 5567.2 5575.6 5589.7 3694.0 3715.1 3733.0 3780.2 3803.0 1068.4 1099.0 1123.9 1124.2 1765.9 11957.2 12063.6 12186.7 12187.6 12233.7 4575.9 4686.5 4703.4 4769.0 4772.5 9422.3 9459.0 9478.4 9488.9 9498.1 5221.9 5234.1 5287.9 5381.8 5425.1 4484.3 4832.5 4986.6 5002.7 5021.9 3825.2 3863.1 3935.7 3950.2 4005.3 1189.7 1190.2 1192.2 1197.5 1201.0 702.8 753.3 812.4 849.5 850.8 5216.5 6103.5 6122.5 6137.5 6191.8 925.6 932.8 942.0 946.0 973.6 4014.6 4087.1 4146.1 4156.6 4166.1 10456.2 10953.0 11034.7 11050.5 11076.4 8477.9 10981.9 10982.0 10986.2 11065.5 7997.3 8315.0 8468.5 8469.4 8490.8 5171.3 5790.9 6056.9 6106.9 6108.0 10187.2 10369.3 10397.2 10404.2 10420.8 9000.8 10412.3 10461.2 10620.2 10652.3 6672.5 7172.5 7212.5 7228.7 7280.5 7277.4 8662.3 8727.4 8757.0 8760.8 6379.6 7417.5 7817.3 7832.1 7866.8 7310.9 7514.2 7530.0 7634.6 7643.4 7104.0 7111.4 7148.4 7180.7 7197.6 4257.7 4802.7 4973.6 5158.3 5181.7 5120.3 5133.8 5136.2 5220.8 5264.9 08:14:37 INFO - PROCESS | 1671 | 08:14:37 INFO - PROCESS | 1671 | [#4] prototype.html Cycles:180 Average:4660.80 Median:5032.16 stddev:1505.21 (29.9%) stddev-sans-first:1473.46 08:14:37 INFO - PROCESS | 1671 | Values: 302.8 310.3 315.9 321.6 323.4 5006.8 5471.3 5600.0 5859.1 5865.9 4432.5 5492.0 5657.2 5667.9 5686.1 3466.3 3649.6 3847.7 4171.4 4350.4 4036.6 4216.7 4287.9 4371.5 4395.5 3513.7 4059.1 4270.8 4316.8 4323.7 4003.4 4186.1 4314.4 4350.5 4353.3 3311.3 3348.2 3415.8 3473.4 3616.2 5062.5 5423.1 5447.4 5452.4 5453.6 3669.4 4094.3 4439.9 4524.1 4793.8 4562.0 5410.5 5653.9 5698.5 5939.7 3314.2 3332.9 3348.0 3957.4 3970.9 4919.5 6088.9 6275.4 6300.0 6353.2 3471.9 3816.8 4040.4 4044.1 4054.0 3544.1 3914.5 4034.9 4102.2 4105.9 4113.4 4281.9 4828.8 4834.0 4852.9 4782.5 5373.9 5848.1 6039.7 6070.4 1373.0 1396.4 1400.5 1413.6 1422.4 716.7 745.5 844.3 849.3 850.9 3817.0 4069.0 4692.3 4729.6 4838.0 4448.5 4631.0 4718.4 4965.6 5255.6 4278.1 4489.7 4625.9 4688.1 4838.6 2894.3 2921.9 2946.6 3292.3 3316.2 6472.9 6475.4 6524.5 6525.8 6531.5 5680.8 5855.9 5864.5 5865.9 6052.7 5797.6 6410.5 6436.2 6455.3 6474.2 4964.8 5341.7 5397.2 6084.7 6262.1 4959.9 5404.8 6117.5 6125.6 6160.2 6401.8 6441.9 6482.7 6507.1 6540.1 3492.8 3805.9 3814.0 4042.8 4045.4 5057.5 5300.7 5895.4 6079.8 6162.4 5185.6 5208.8 5512.6 5609.3 6062.2 5518.4 5606.9 5930.8 5948.9 5975.5 5760.8 5808.8 5829.4 5876.4 5901.2 5250.7 5608.5 5844.4 5976.2 5992.4 5569.3 5870.1 5870.4 5895.5 5946.3 08:14:37 INFO - PROCESS | 1671 | 08:14:37 INFO - PROCESS | 1671 | [#5] yui.html Cycles:180 Average:18763.84 Median:4658.80 stddev:25604.80 (549.6%) stddev-sans-first:25640.59 08:14:37 INFO - PROCESS | 1671 | Values: 671.0 687.3 692.1 750.0 820.3 14049.5 14698.3 14828.0 14831.3 14874.9 11917.5 14045.2 14079.6 14087.8 14119.2 707.0 871.0 893.0 912.2 917.2 899.0 901.3 905.7 908.6 909.6 964.9 967.0 967.5 969.2 969.6 795.2 952.7 956.1 960.8 964.6 592.4 709.0 710.4 710.7 712.0 14415.2 14785.0 14794.6 14933.4 14987.2 14388.9 14423.4 14452.8 14493.3 14493.4 10292.4 11071.4 11237.3 11270.9 11464.1 3314.8 3809.7 3863.7 3870.3 3898.3 82351.0 85587.0 85847.6 86401.6 86885.0 10942.6 11052.2 11150.2 11278.8 11543.8 22478.8 22481.0 22509.0 22512.8 22524.5 7887.9 8003.4 8132.3 8338.4 8352.6 4407.7 4465.5 4494.7 4506.1 4519.2 3482.1 3545.5 3557.1 3602.2 3603.2 594.5 658.9 671.7 673.9 674.7 605.0 650.5 695.7 708.0 724.9 9389.5 9528.7 9701.9 9718.8 9822.5 542.7 603.5 619.4 687.2 691.5 4064.2 4271.6 4534.0 4618.3 4699.3 90105.0 90613.1 91128.0 91980.5 92564.5 70950.0 80330.0 80902.6 83666.0 84670.0 51776.7 69215.9 76951.0 77127.6 77305.0 7441.0 8656.5 8690.5 9454.0 9569.8 36187.4 43912.6 44726.8 48107.8 48205.3 58387.7 58578.2 65042.0 66415.7 67360.3 12778.7 12851.7 12938.3 13023.2 13476.2 14420.6 14434.9 14478.0 14577.2 14677.7 12904.7 13401.9 13476.4 13725.7 14019.0 13200.1 13303.5 13448.3 13496.5 13792.6 11788.5 12123.8 12953.6 13153.9 13671.2 10477.8 10914.8 11106.7 11131.2 11539.2 8256.6 10557.4 11107.9 11158.0 11371.1 08:14:37 INFO - PROCESS | 1671 | -------- Summary: end -------- 08:14:37 INFO - PROCESS | 1671 | 08:14:37 INFO - TEST-INFO | 1671: exit 0 08:14:37 INFO - TEST-OK | dromaeo_css | took 1111570ms 08:14:37 INFO - TEST-START | kraken 08:14:37 INFO - operating with platform_type : mac_ 08:14:37 INFO - Initialising browser for kraken test... 08:14:37 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/tmp2miWff/profile http://localhost:49276/getInfo.html) 08:14:40 INFO - PROCESS | 1679 | __metrics Screen width/height:1600/1200 08:14:40 INFO - PROCESS | 1679 | colorDepth:24 08:14:40 INFO - PROCESS | 1679 | Browser inner width/height: 1024/689 08:14:40 INFO - PROCESS | 1679 | __metrics 08:14:40 ERROR - PROCESS | 1679 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 08:14:41 INFO - TEST-INFO | 1679: exit 0 08:14:41 INFO - Browser initialized. 08:14:41 INFO - Running cycle 1/1 for kraken test... 08:14:41 INFO - TEST-INFO | started process 1681 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/tmp2miWff/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:14:53 INFO - PROCESS | 1681 | RSS: Main: 251887616 08:14:53 INFO - PROCESS | 1681 | 08:14:55 INFO - PROCESS | 1681 | 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) 08:14:56 INFO - PROCESS | 1681 | RSS: Main: 264634368 08:14:56 INFO - PROCESS | 1681 | 08:14:59 INFO - PROCESS | 1681 | 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) 08:14:59 INFO - PROCESS | 1681 | RSS: Main: 268996608 08:14:59 INFO - PROCESS | 1681 | 08:15:03 INFO - PROCESS | 1681 | 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) 08:15:04 INFO - PROCESS | 1681 | RSS: Main: 269549568 08:15:04 INFO - PROCESS | 1681 | 08:15:06 INFO - PROCESS | 1681 | 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) 08:15:06 INFO - PROCESS | 1681 | RSS: Main: 270557184 08:15:06 INFO - PROCESS | 1681 | 08:15:08 INFO - PROCESS | 1681 | 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) 08:15:09 INFO - PROCESS | 1681 | RSS: Main: 271101952 08:15:09 INFO - PROCESS | 1681 | 08:15:12 INFO - PROCESS | 1681 | 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) 08:15:12 INFO - PROCESS | 1681 | RSS: Main: 271007744 08:15:12 INFO - PROCESS | 1681 | 08:15:16 INFO - PROCESS | 1681 | 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) 08:15:16 INFO - PROCESS | 1681 | RSS: Main: 271343616 08:15:16 INFO - PROCESS | 1681 | 08:15:19 INFO - PROCESS | 1681 | 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) 08:15:20 INFO - PROCESS | 1681 | RSS: Main: 271519744 08:15:20 INFO - PROCESS | 1681 | 08:15:21 INFO - PROCESS | 1681 | 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) 08:15:22 INFO - PROCESS | 1681 | RSS: Main: 270864384 08:15:22 INFO - PROCESS | 1681 | 08:15:24 INFO - PROCESS | 1681 | 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) 08:15:25 INFO - PROCESS | 1681 | RSS: Main: 271134720 08:15:25 INFO - PROCESS | 1681 | 08:15:27 INFO - PROCESS | 1681 | 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) 08:15:28 INFO - PROCESS | 1681 | RSS: Main: 271519744 08:15:28 INFO - PROCESS | 1681 | 08:15:30 INFO - PROCESS | 1681 | 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) 08:15:31 INFO - PROCESS | 1681 | RSS: Main: 271446016 08:15:31 INFO - PROCESS | 1681 | 08:15:34 INFO - PROCESS | 1681 | 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) 08:15:34 INFO - PROCESS | 1681 | RSS: Main: 271405056 08:15:34 INFO - PROCESS | 1681 | 08:15:36 INFO - PROCESS | 1681 | 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) 08:15:37 INFO - PROCESS | 1681 | RSS: Main: 272371712 08:15:37 INFO - PROCESS | 1681 | 08:15:37 INFO - PROCESS | 1681 | __start_tp_report 08:15:37 INFO - PROCESS | 1681 | _x_x_mozilla_page_load 08:15:37 INFO - PROCESS | 1681 | _x_x_mozilla_page_load_details 08:15:37 INFO - PROCESS | 1681 | |i|pagename|runs| 08:15:37 INFO - PROCESS | 1681 | |0;ai-astar;113;107;116;114;116;115;112;111;116;114 08:15:37 INFO - PROCESS | 1681 | |1;audio-beat-detection;161;139;177;192;147;141;136;139;166;120 08:15:37 INFO - PROCESS | 1681 | |2;audio-dft;199;202;205;240;251;194;209;274;196;196 08:15:37 INFO - PROCESS | 1681 | |3;audio-fft;60;108;66;180;51;66;80;50;133;84 08:15:37 INFO - PROCESS | 1681 | |4;audio-oscillator;71;71;126;70;71;74;111;68;73;112 08:15:37 INFO - PROCESS | 1681 | |5;imaging-gaussian-blur;89;99;135;86;89;88;89;75;136;135 08:15:37 INFO - PROCESS | 1681 | |6;imaging-darkroom;95;145;95;143;152;96;97;117;155;111 08:15:37 INFO - PROCESS | 1681 | |7;imaging-desaturate;108;121;142;152;89;88;92;89;91;94 08:15:37 INFO - PROCESS | 1681 | |8;json-parse-financial;57;58;58;54;56;56;58;57;56;56 08:15:37 INFO - PROCESS | 1681 | |9;json-stringify-tinderbox;67;69;83;62;70;102;107;101;101;88 08:15:37 INFO - PROCESS | 1681 | |10;stanford-crypto-aes;88;85;87;90;89;86;87;87;120;88 08:15:37 INFO - PROCESS | 1681 | |11;stanford-crypto-ccm;140;138;138;136;135;149;154;127;147;139 08:15:37 INFO - PROCESS | 1681 | |12;stanford-crypto-pbkdf2;165;167;169;163;169;164;167;227;225;177 08:15:37 INFO - PROCESS | 1681 | |13;stanford-crypto-sha256-iterative;70;65;62;60;69;88;84;85;90;67 08:15:37 INFO - PROCESS | 1681 | __end_tp_report 08:15:37 INFO - PROCESS | 1681 | __start_cc_report 08:15:37 INFO - PROCESS | 1681 | _x_x_mozilla_cycle_collect,1068 08:15:37 INFO - PROCESS | 1681 | __end_cc_report 08:15:37 INFO - PROCESS | 1681 | __startTimestamp1464362137019__endTimestamp 08:15:37 INFO - PROCESS | 1681 | 08:15:37 INFO - PROCESS | 1681 | ------- Summary: start ------- 08:15:37 INFO - PROCESS | 1681 | Number of tests: 14 08:15:37 INFO - PROCESS | 1681 | 08:15:37 INFO - PROCESS | 1681 | [#0] ai-astar Cycles:10 Average:113.40 Median:114.50 stddev:2.84 (2.5%) stddev-sans-first:3.00 08:15:37 INFO - PROCESS | 1681 | Values: 113.0 107.0 116.0 114.0 116.0 115.0 112.0 111.0 116.0 114.0 08:15:37 INFO - PROCESS | 1681 | 08:15:37 INFO - PROCESS | 1681 | [#1] audio-beat-detection Cycles:10 Average:151.80 Median:154.00 stddev:21.77 (14.1%) stddev-sans-first:22.84 08:15:37 INFO - PROCESS | 1681 | Values: 161.0 139.0 177.0 192.0 147.0 141.0 136.0 139.0 166.0 120.0 08:15:37 INFO - PROCESS | 1681 | 08:15:37 INFO - PROCESS | 1681 | [#2] audio-dft Cycles:10 Average:216.60 Median:207.00 stddev:28.09 (13.6%) stddev-sans-first:29.06 08:15:37 INFO - PROCESS | 1681 | Values: 199.0 202.0 205.0 240.0 251.0 194.0 209.0 274.0 196.0 196.0 08:15:37 INFO - PROCESS | 1681 | 08:15:37 INFO - PROCESS | 1681 | [#3] audio-fft Cycles:10 Average:87.80 Median:63.00 stddev:41.54 (65.9%) stddev-sans-first:42.83 08:15:37 INFO - PROCESS | 1681 | Values: 60.0 108.0 66.0 180.0 51.0 66.0 80.0 50.0 133.0 84.0 08:15:37 INFO - PROCESS | 1681 | 08:15:37 INFO - PROCESS | 1681 | [#4] audio-oscillator Cycles:10 Average:84.70 Median:71.00 stddev:22.24 (31.3%) stddev-sans-first:23.03 08:15:37 INFO - PROCESS | 1681 | Values: 71.0 71.0 126.0 70.0 71.0 74.0 111.0 68.0 73.0 112.0 08:15:37 INFO - PROCESS | 1681 | 08:15:37 INFO - PROCESS | 1681 | [#5] imaging-gaussian-blur Cycles:10 Average:102.10 Median:88.50 stddev:23.64 (26.7%) stddev-sans-first:24.60 08:15:37 INFO - PROCESS | 1681 | Values: 89.0 99.0 135.0 86.0 89.0 88.0 89.0 75.0 136.0 135.0 08:15:37 INFO - PROCESS | 1681 | 08:15:37 INFO - PROCESS | 1681 | [#6] imaging-darkroom Cycles:10 Average:120.60 Median:125.00 stddev:25.48 (20.4%) stddev-sans-first:25.29 08:15:37 INFO - PROCESS | 1681 | Values: 95.0 145.0 95.0 143.0 152.0 96.0 97.0 117.0 155.0 111.0 08:15:37 INFO - PROCESS | 1681 | 08:15:37 INFO - PROCESS | 1681 | [#7] imaging-desaturate Cycles:10 Average:106.60 Median:89.00 stddev:23.82 (26.8%) stddev-sans-first:25.25 08:15:37 INFO - PROCESS | 1681 | Values: 108.0 121.0 142.0 152.0 89.0 88.0 92.0 89.0 91.0 94.0 08:15:37 INFO - PROCESS | 1681 | 08:15:37 INFO - PROCESS | 1681 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:57.00 stddev:1.26 (2.2%) stddev-sans-first:1.33 08:15:37 INFO - PROCESS | 1681 | Values: 57.0 58.0 58.0 54.0 56.0 56.0 58.0 57.0 56.0 56.0 08:15:37 INFO - PROCESS | 1681 | 08:15:37 INFO - PROCESS | 1681 | [#9] json-stringify-tinderbox Cycles:10 Average:85.00 Median:68.00 stddev:17.10 (25.1%) stddev-sans-first:16.85 08:15:37 INFO - PROCESS | 1681 | Values: 67.0 69.0 83.0 62.0 70.0 102.0 107.0 101.0 101.0 88.0 08:15:37 INFO - PROCESS | 1681 | 08:15:37 INFO - PROCESS | 1681 | [#10] stanford-crypto-aes Cycles:10 Average:90.70 Median:87.50 stddev:10.39 (11.9%) stddev-sans-first:10.98 08:15:37 INFO - PROCESS | 1681 | Values: 88.0 85.0 87.0 90.0 89.0 86.0 87.0 87.0 120.0 88.0 08:15:37 INFO - PROCESS | 1681 | 08:15:37 INFO - PROCESS | 1681 | [#11] stanford-crypto-ccm Cycles:10 Average:140.30 Median:139.50 stddev:7.78 (5.6%) stddev-sans-first:8.25 08:15:37 INFO - PROCESS | 1681 | Values: 140.0 138.0 138.0 136.0 135.0 149.0 154.0 127.0 147.0 139.0 08:15:37 INFO - PROCESS | 1681 | 08:15:37 INFO - PROCESS | 1681 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.30 Median:169.00 stddev:24.92 (14.7%) stddev-sans-first:25.89 08:15:37 INFO - PROCESS | 1681 | Values: 165.0 167.0 169.0 163.0 169.0 164.0 167.0 227.0 225.0 177.0 08:15:37 INFO - PROCESS | 1681 | 08:15:37 INFO - PROCESS | 1681 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.00 Median:77.00 stddev:11.47 (14.9%) stddev-sans-first:12.07 08:15:37 INFO - PROCESS | 1681 | Values: 70.0 65.0 62.0 60.0 69.0 88.0 84.0 85.0 90.0 67.0 08:15:37 INFO - PROCESS | 1681 | -------- Summary: end -------- 08:15:37 INFO - PROCESS | 1681 | 08:15:37 INFO - TEST-INFO | 1681: exit 0 08:15:37 INFO - TEST-OK | kraken | took 60215ms 08:15:37 INFO - SUITE-END | took 1171s 08:15:38 INFO - Completed test suite (00:19:32) 08:15:38 INFO - javascript benchmark 08:15:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7225.345238067386, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3211.7912335698184, 3541.256336169404, 3543.5747710274773, 3566.9477504136275, 3589.0489020409595, 5815.883682326356, 5871.354151043387, 5937.436147892693, 5947.821565353041, 6039.72821223045, 5893.145493903392, 5920.378360272174, 5961.61249518781, 6014.368491308404, 6046.606970546923, 5342.065138600739, 5373.355197376321, 5477.67133971961, 5480.424555421683, 5584.6090773645865, 29.0814676602447, 5294.867628309304, 5371.435999220084, 5438.320209973754, 5439.755211015494, 5417.6478528895495, 5438.592105592096, 5452.073147564924, 5474.151506516477, 5479.0959491683825, 5459.099248624012, 5459.754311056012, 5463.344398672145, 5492.12529813327, 5514.145307477347, 5314.309139811839, 5329.760160792774, 5335.226392173152, 5385.973070134624, 5408.729563521848, 5745.368009518949, 5819.709014549256, 5863.736131874076, 5885.087811389199, 5925.377835327315, 6179.0, 6269.780557680459, 6322.0, 6327.209098862642, 6333.334999825044, 6295.811125666238, 6359.268684101341, 6365.554411191219, 6430.1319321891415, 6432.51756118293, 6147.016477363601, 6162.0, 6167.136600875836, 6168.87662246757, 6171.444569988723, 6262.436380725757, 6337.4613157882095, 6559.344065593403, 6564.048213009087, 6566.6388348641285, 6188.752449902044, 6193.318734939153, 6205.348438413992, 6229.719662615194, 6265.216847894013, 5050.72221027847, 6348.587341822767, 6360.204974378203, 6397.008463688136, 6404.935950640527, 5165.509276618715, 6214.9689251553455, 6233.906491402633, 6281.183446151971, 6315.179026726588, 6261.405166509266, 6271.216097987752, 6288.025356069817, 6292.087647291117, 6305.337939516285, 5117.385913690381, 5126.8974620508125, 5129.9743501283, 5136.614753893473, 5139.948600514022, 4449.555044495589, 4497.370368148462, 4499.257622492252, 4619.6073333766335, 4669.995950870579, 4688.484266730657, 6008.279006519246, 6054.788082417094, 6058.394160583995, 6106.460667179974, 6346.746130154742, 6370.936290637034, 6389.6805159741825, 6392.26488953767, 6394.424501794861, 5941.287045554474, 6049.485793707584, 6072.05883088122, 6102.572819902653, 6111.144439778434, 5085.830259040441, 5274.235235890851, 5562.193481945176, 5583.162525621189, 5593.8321850344555, 6369.808905732835, 6613.834654133589, 6615.0, 6628.171478565179, 6637.1703537057865, 6263.937360626518, 6300.369963003663, 6316.242050953915, 6410.038494225717, 6423.550351475352, 6591.472682185509, 6606.8017959461295, 6609.4712423007, 6631.701573429304, 6643.900341494785, 6173.84565385869, 6194.752209911553, 6315.810525684236, 6318.4313411793155, 6348.9047664286, 6268.655223962726, 6338.397852204033, 6398.584092034003, 6425.58233714807, 6426.325235850169, 6031.577789554689, 6180.845478863064, 6223.906641400473, 6239.313675495601, 6257.186565746424, 6138.480361557057, 6168.660723660242, 6217.626942383471, 6220.222472190976, 6237.220347456568, 6036.336003039574, 6165.4451099399475, 6216.067589861557, 6218.253809542884, 6239.251289845248, 6229.875402492015, 6234.594751341148, 6243.188385509855, 6246.3441338660605, 6248.156498872776, 6096.2243283589, 6105.786297479567, 6135.386461353829, 6162.322144564184, 6195.566310358232], "value": 5821.5571387874315, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [497.4726789603021, 508.80411041748926, 509.5770510476305, 549.8432946610217, 575.4763165519373, 39150.80424597877, 41545.584544154546, 41553.37669934954, 41557.376639350434, 41667.16665666689, 42106.36840447396, 42854.7857260714, 42912.78543607277, 42971.570284297144, 42982.785086074604, 9437.386569872971, 9662.32363734539, 9675.080867317629, 9685.612575497007, 9703.90296097037, 9563.856542151838, 9564.66094746736, 9643.469609171492, 9659.903400966006, 9686.32195746298, 8165.591720413956, 9659.517024148765, 9671.129598336149, 9682.709518714415, 9683.806323873518, 8280.83438331236, 9629.855552166724, 9632.614695412176, 9644.08381203788, 9662.75843103921, 9526.285528585384, 9675.806483870283, 9703.17523010545, 9709.271804614682, 9710.61157553697, 39897.40153897694, 40078.39882401766, 40328.39507407391, 40451.19097618031, 40600.796996015124, 2781.694013658496, 3168.588083549147, 3294.456414691573, 3459.70261152068, 3560.1989552350774, 22619.321420357417, 30266.54600180999, 30361.392772144434, 30982.845085774654, 31015.379692406026, 2905.721482547672, 2978.0, 3073.3853229354218, 3122.81263124211, 3128.671489493593, 387840.0, 426590.6011409831, 441095.0, 475581.24418755714, 477573.6121319406, 33377.16557086044, 34832.0, 34905.778297759454, 35136.47295290573, 35145.82427087848, 30330.393392132035, 31109.844450778055, 35725.64274357275, 35820.0, 36539.817300913324, 16838.326466941184, 17197.140142993052, 17205.0, 17216.827831721774, 17274.309027639007, 12885.613431597067, 12940.15888967214, 13074.411651475706, 13175.67060823468, 13392.129511581716, 19100.662953593113, 19180.808191918182, 20248.898755506423, 20454.0, 20536.486587835127, 7035.8241043973285, 7129.754127449837, 7827.099883513355, 8482.049128700433, 8531.95734021326, 805.3637626275294, 832.7876391520244, 1158.212415557429, 1172.8827117288204, 1177.181858608259, 29689.703102969124, 31149.688503115132, 31725.841370792998, 31776.0, 31943.881964131146, 1007.4559737741685, 1061.4109169411051, 1144.8511693479795, 1168.6727716239466, 1234.8703386144505, 16131.790115741367, 16179.514614561582, 16284.83715162857, 16510.587235319214, 16536.0, 662889.0, 669742.0, 670209.0, 671359.0, 671505.0, 48423.75788121107, 49371.75314123478, 60122.39877601168, 60196.097058544154, 60290.69854650699, 1391.6938273579797, 1433.62725691321, 1446.2190417174818, 1448.1455940994863, 1448.3482432905234, 30443.695563044974, 30464.867459277637, 30721.078367649006, 30809.69190308158, 31214.21964450907, 51998.0, 52025.21962170495, 52541.7372913133, 52775.20837187522, 52836.73581632067, 514026.0, 515375.0, 515988.0, 517150.0, 520225.0, 27605.309867252676, 27954.440911182068, 28038.719612803612, 28712.282192945342, 28810.703518341306, 48952.51047489479, 49428.50571494239, 49705.50294497009, 49953.0, 50496.99006019933, 39179.60820391874, 40826.0, 40912.0, 41244.38133428061, 41426.171476570904, 40302.99242518961, 40407.59592404038, 40614.0, 40985.590144098176, 41215.79392103021, 38127.42808857814, 38671.22657546889, 39602.40596390999, 39710.0, 39814.2037159261, 31228.0, 36453.0, 36942.44586331261, 37333.43999840059, 37375.62624373721, 21027.369178924044, 26020.479590407707, 26313.73686263113, 26351.604725928744, 26801.927922883646], "value": 19602.716928711518, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.5506894726857, 318.39504940612846, 364.75014614988726, 371.11859334081555, 401.4660501532961, 14015.018948673584, 20044.89977550112, 20855.95720213989, 20870.68693969588, 20897.26859559916, 16940.83059169408, 19691.31080412186, 19901.800981990174, 20729.792702072973, 20787.792122078776, 4989.57588604969, 5608.775648974036, 5836.241288632493, 5861.941380586182, 5867.76528938842, 4346.348047792825, 5737.082066869301, 5753.769849206027, 5814.24414826072, 5822.912656310159, 5633.7183140843, 5781.421857814227, 5997.760089596432, 6408.551401401881, 6411.390917862819, 5397.163439666858, 6390.6804659767295, 6431.035344698286, 6435.6138631682015, 6584.374484423972, 5782.248307720011, 5820.272465941757, 5839.970800146015, 5868.8239352819055, 5868.882622347529, 13173.538926137539, 17647.5588110297, 23438.0, 24716.382090447703, 24731.87634061836, 2168.620491413996, 2199.373178644095, 2260.175036111824, 2264.218844498662, 2518.26970178648, 9158.587863546156, 9185.035571265054, 9917.603295868157, 9932.205423566098, 10050.59797608102, 1807.6203997160612, 1843.5759775251634, 1901.4390754727388, 1917.7027560728109, 1953.3749200255925, 108626.0, 113792.43103784428, 117642.82357176405, 126009.36995315057, 126755.0, 10130.645427410005, 10359.533820978075, 11414.486348114355, 11468.566429196351, 11500.309981401142, 14129.293535323193, 14322.85677143236, 14392.0, 14423.78364324536, 14430.711385772225, 8471.0, 8538.487690738575, 8585.742427727178, 8630.95684521586, 8661.177188167114, 7033.366996970297, 8564.871526927102, 8573.356998225034, 8669.133086691281, 8679.0, 4456.86629401112, 4537.523560026149, 4554.282433410693, 4558.202314594999, 4626.514216007271, 1778.9822101779075, 1897.8007309232332, 1920.6363481927708, 1932.584494333697, 1942.4852414110271, 789.759123467348, 849.9320054395633, 865.0182043380809, 993.8360170571775, 1018.0989824005808, 10710.196735244888, 10815.513301901276, 10880.72798180036, 11409.315441073562, 11564.537418503334, 419.5804195804196, 438.9978050109729, 442.6149250152388, 446.3015380928836, 448.33646203618827, 6000.369961154016, 6065.514758819284, 6127.571070025056, 6145.754169833246, 6146.0, 612210.0, 618667.0, 619917.0, 622689.0, 624175.8791206105, 98229.0, 120703.0, 122589.38705306416, 125001.0, 127108.0, 457.9610733087725, 461.1261659155881, 462.09660114476117, 463.4716423277466, 463.9141758774638, 10931.0, 11016.283941543774, 11163.665090047312, 11229.71925701864, 11307.151963602928, 47487.86304616232, 52248.69378265574, 52343.73828130835, 52714.73642631762, 52999.73500132629, 72361.6381918087, 73621.26378736144, 74730.25269747233, 75157.0, 75570.62214688891, 11356.659300221007, 11496.367699776592, 11745.647630571097, 11805.468753905923, 12013.399330033288, 10421.895781042092, 12715.237085774883, 12837.679058023625, 12914.870851291367, 13049.608511744664, 10987.121030317716, 11007.779844403227, 11278.0, 11295.830562541403, 11304.547818087185, 9043.638254469748, 11006.339619622848, 11175.497102630563, 11280.210385272952, 11286.266392684778, 11369.772604548029, 11550.306981581132, 11552.278313481103, 11662.475188616701, 11682.12384071181, 11707.180497365103, 11818.995385391994, 11925.940370298093, 11932.761344772882, 11945.2832830027, 11356.716082098013, 11358.432078396212, 11411.486483108114, 11423.657290281304, 11463.942680286878], "value": 8787.821767799249, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1502.2713983717895, 1560.0093940347876, 1764.647070585883, 1889.3198448558517, 1898.743669604603, 8090.393220508471, 8331.250187483125, 8784.0, 9342.953285233565, 9364.812703745922, 7405.629718514067, 8950.23922966547, 9130.680426185085, 9132.269418446525, 9169.266458683305, 2400.2319257837457, 2428.7935525480357, 2429.465517586137, 2432.0636554926305, 2446.449548851512, 2022.2416593777334, 2396.2451827674313, 2432.622943443769, 2433.707955045397, 2438.829281950264, 1984.2856571634272, 2376.0495801679294, 2384.7853693167613, 2389.5340408620327, 2399.664047033417, 2315.108683156997, 2350.553394854972, 2370.1941339944415, 2373.762623737621, 2397.832151749378, 2365.6451532270125, 2379.3575734551746, 2382.3805810489225, 2386.0813586769045, 2392.246442370648, 7783.805404864867, 9085.636574537011, 9101.0, 9143.817123657556, 9149.81700365989, 5445.727713614304, 5561.082421400464, 5567.248421463091, 5575.553955683536, 5589.720513974285, 3694.0, 3715.10837399025, 3733.0028434787528, 3780.206156707095, 3802.99220706513, 1068.3803394031443, 1098.9505472253768, 1123.915706322021, 1124.235519846504, 1765.920533575992, 11957.222780519238, 12063.638090857288, 12186.695332616668, 12187.573434929824, 12233.694157646041, 4575.908481830411, 4686.531346865286, 4703.3885594872445, 4768.976155119202, 4772.546608072227, 9422.293328000427, 9459.0, 9478.431294122374, 9488.905110948941, 9498.09768072032, 5221.869453263623, 5234.110201265794, 5287.894242115136, 5381.838544843661, 5425.077736784756, 4484.260097084009, 4832.4684284728655, 4986.626003049713, 5002.724850133205, 5021.949780502148, 3825.1967086911504, 3863.092173339263, 3935.704822138351, 3950.249452603996, 4005.2990726623307, 1189.6787867275787, 1190.2441949362044, 1192.1535709646248, 1197.479096592985, 1200.9579664711694, 702.7575486457164, 753.3408267765705, 812.4150611559668, 849.524266410812, 850.80461950959, 5216.530512253916, 6103.481204097613, 6122.479589234876, 6137.508999280047, 6191.752329906753, 925.5742358515158, 932.7780607404322, 942.0438255171007, 945.9716208513755, 973.5862258540092, 4014.558398576154, 4087.141700242982, 4146.108586653884, 4156.605122513417, 4166.104287578185, 10456.215783816244, 10953.0, 11034.724131896606, 11050.502727377287, 11076.446177691083, 8477.872831907527, 10981.901809819114, 10982.0, 10986.176036797113, 11065.50205240766, 7997.280244777998, 8315.04376996641, 8468.534230617375, 8469.364797640079, 8490.830183396298, 5171.3277273954145, 5790.9420905792085, 6056.939430605637, 6106.9083963739695, 6108.0, 10187.185025198114, 10369.325993810378, 10397.168226541708, 10404.167666586503, 10420.791584168426, 9000.81998360016, 10412.271141020055, 10461.163106951273, 10620.15038796879, 10652.254342195973, 6672.499562532732, 7172.49792514519, 7212.4951253411755, 7228.710851565878, 7280.526765760209, 7277.38142257914, 8662.263707584674, 8727.389082764146, 8757.0, 8760.817289665814, 6379.585326953733, 7417.517861338995, 7817.257360550739, 7832.0601527817025, 7866.842663146819, 7310.8903366448485, 7514.248575142442, 7530.021097257321, 7634.618269086634, 7643.4267429941865, 7104.040954471287, 7111.359977602041, 7148.392386647193, 7180.748673796392, 7197.604131772803, 4257.659387249075, 4802.727277271456, 4973.557668276304, 5158.277841102174, 5181.740912954262, 5120.334356533627, 5133.820316288912, 5136.229565565195, 5220.817271395483, 5264.86837829042], "value": 4636.612817908111, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.7941000119919, 310.3173019357414, 315.8736505397841, 321.5723088292571, 323.3887951771153, 5006.774695138718, 5471.261379713737, 5599.972000140004, 5859.121131830228, 5865.941340586593, 4432.492952396185, 5492.038893193695, 5657.207990881269, 5667.943320566793, 5686.147077938312, 3466.341395134929, 3649.562052553684, 3847.7498962567342, 4171.3742938559235, 4350.390945267649, 4036.5871944819223, 4216.746995180284, 4287.942946289277, 4371.519132895379, 4395.450568678915, 3513.7013353864954, 4059.147579008412, 4270.807813648394, 4316.762578058206, 4323.718958267718, 4003.4395184674167, 4186.099988502471, 4314.352847072949, 4350.543192964757, 4353.28170851809, 3311.337732453519, 3348.179695974502, 3415.8121303328307, 3473.392156372625, 3616.222512159898, 5062.519060689228, 5423.132298832207, 5447.373552041487, 5452.4274951129955, 5453.609329620961, 3669.412893936957, 4094.324436467979, 4439.933400998988, 4524.11779702958, 4793.784279707422, 4562.0, 5410.513053825135, 5653.8586535336535, 5698.544116470714, 5939.67331796751, 3314.171457135716, 3332.900012999614, 3347.96652033479, 3957.357696555926, 3970.9007274818073, 4919.532644398776, 6088.903997280488, 6275.372462753734, 6299.968500157515, 6353.188087147721, 3471.930561388758, 3816.8091595420674, 4040.3939409088284, 4044.0900797320955, 4053.9797301013305, 3544.113971507123, 3914.4715463412645, 4034.919301613951, 4102.200070986189, 4105.876823695294, 4113.4035564843525, 4281.935770963438, 4828.806847726122, 4834.0, 4852.8544143675745, 4782.497837727058, 5373.892522149535, 5848.058032491427, 6039.667818270037, 6070.361002529292, 1372.9771320366192, 1396.3871728154, 1400.4608225833128, 1413.590058882933, 1422.4025909118195, 716.7240612364277, 745.4595418321674, 844.3118858130604, 849.3078141314809, 850.9361797865184, 3816.9618303816605, 4069.0, 4692.319613656069, 4729.597984171384, 4838.0, 4448.510663826976, 4631.0, 4718.41019872516, 4965.553100220925, 5255.633535280855, 4278.101598664253, 4489.73061616304, 4625.889786451227, 4688.077888065876, 4838.588719958772, 2894.2908987297824, 2921.8539073046686, 2946.583801282927, 3292.3086151907887, 3316.1875340541724, 6472.935270647327, 6475.417212450902, 6524.543281970216, 6525.836854078686, 6531.542792004514, 5680.7727690892725, 5855.887381397521, 5864.501517370986, 5865.94134058654, 6052.66710330936, 5797.623154495029, 6410.525579116736, 6436.195475565554, 6455.322191169954, 6474.1907261592305, 4964.799571041191, 5341.732913354394, 5397.244385785914, 6084.69576521181, 6262.091996660368, 4959.876003099951, 5404.8108316208745, 6117.543587872838, 6125.6110117053495, 6160.182746090004, 6401.807945761635, 6441.903371449338, 6482.740690372332, 6507.089007539043, 6540.117084193573, 3492.825358732104, 3805.923881522299, 3813.951163430079, 4042.838286468626, 4045.3527435610163, 5057.544820966131, 5300.655457395257, 5895.4399332063385, 6079.817605471843, 6162.383761623802, 5185.585153187812, 5208.8437346879655, 5512.641678290898, 5609.298837645294, 6062.151298818081, 5518.448155184449, 5606.906653202586, 5930.7924222652, 5948.910766338422, 5975.521958243417, 5760.8271751847515, 5808.82573522795, 5829.387914268941, 5876.41235876409, 5901.232839730807, 5250.65870718402, 5608.523275521627, 5844.357120716632, 5976.19321391624, 5992.400759923973, 5569.275994120739, 5870.119482077723, 5870.442307980735, 5895.526118470382, 5946.345901950868], "value": 4180.525915415145, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [670.9630970296631, 687.3126873126873, 692.1417442371461, 750.0174771049925, 820.33552822214, 14049.508267210636, 14698.338574764135, 14828.0, 14831.258437078157, 14874.925625371858, 11917.463714132864, 14045.227512486834, 14079.57761267161, 14087.788683169761, 14119.223442710647, 707.0243064570885, 870.960806763694, 892.9687460938868, 912.1835956818643, 917.1699611851285, 898.9820203595924, 901.33301356996, 905.7146998695423, 908.5638893331205, 909.5679552212712, 964.8986856380084, 967.0377973915963, 967.4678926590383, 969.2197780786464, 969.5830792759111, 795.1650766694947, 952.6856137474617, 956.063058202958, 960.812641534901, 964.5804075227298, 592.3927973826862, 708.9822754431129, 710.431654676262, 710.70860947012, 712.0458585495461, 14415.207163605997, 14785.038972466755, 14794.630134246623, 14933.402663893432, 14987.175705336202, 14388.92805535976, 14423.423063077464, 14452.783208251885, 14493.275336233146, 14493.420263189566, 10292.382457052601, 11071.446427678584, 11237.26957747752, 11270.887291127066, 11464.140189485823, 3314.751393645462, 3809.676177524914, 3863.652271295597, 3870.3033453978273, 3898.2788184186015, 82351.0, 85587.0, 85847.57076214641, 86401.56799216027, 86885.0, 10942.617008404668, 11052.226344155832, 11150.21948463616, 11278.81572434899, 11543.76912461763, 22478.775212247994, 22481.0, 22509.0, 22512.774872251397, 22524.54950900973, 7887.921120788834, 8003.439759216799, 8132.2680958714, 8338.416310858303, 8352.582370881431, 4407.6914615976575, 4465.531677365313, 4494.685372023927, 4506.1213063452315, 4519.231730605805, 3482.077249528877, 3545.4859045438784, 3557.1285035166034, 3602.2075143468396, 3603.1892824114366, 594.46201187925, 658.9472842172614, 671.6876652356677, 673.9056532085511, 674.652553934724, 604.9667268300286, 650.5446187668651, 695.7495301691387, 707.9663691011078, 724.9093863267092, 9389.483578403117, 9528.714138575853, 9701.854472182922, 9718.75703107428, 9822.459764712867, 542.6581253810075, 603.5081408652022, 619.4301242856583, 687.1792831854902, 691.5021184746975, 4064.248114098901, 4271.551487093872, 4533.977330113395, 4618.330342100377, 4699.271612900006, 90105.0, 90613.09386906179, 91128.0, 91980.54009730043, 92564.53717731369, 70950.0, 80330.0, 80902.59548702219, 83666.0, 84670.0, 51776.74111629418, 69215.92352229341, 76951.0, 77127.61436192783, 77305.0, 7440.962795185989, 8656.523891186045, 8690.478571285743, 9453.952730236304, 9569.760755981157, 36187.37156828002, 43912.560874390845, 44726.77636611796, 48107.75946120247, 48205.276920845514, 58387.70806146112, 58578.24265272049, 65042.024369633546, 66415.66792166009, 67360.32639673736, 12778.744425111632, 12851.678708032374, 12938.330114100181, 13023.153495022792, 13476.249733518898, 14420.567382978528, 14434.927825360806, 14478.0, 14577.198254095701, 14677.706445871236, 12904.677383065498, 13401.86598134006, 13476.393562289524, 13725.725485490433, 14019.0, 13200.14199077057, 13303.534376296782, 13448.327583620585, 13496.491271882962, 13792.586222413343, 11788.528458861549, 12123.75752484963, 12953.611391658265, 13153.94768418505, 13671.17972921628, 10477.790444191225, 10914.781704365709, 11106.672791547613, 11131.220814542905, 11539.192256542297, 8256.587170641324, 10557.366558006237, 11107.94446027797, 11158.0, 11371.090312775124], "value": 7318.815203975423, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1609.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 107.0, 116.0, 114.0, 116.0, 115.0, 112.0, 111.0, 116.0, 114.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 139.0, 177.0, 192.0, 147.0, 141.0, 136.0, 139.0, 166.0, 120.0], "value": 151.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 202.0, 205.0, 240.0, 251.0, 194.0, 209.0, 274.0, 196.0, 196.0], "value": 216.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 108.0, 66.0, 180.0, 51.0, 66.0, 80.0, 50.0, 133.0, 84.0], "value": 87.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 126.0, 70.0, 71.0, 74.0, 111.0, 68.0, 73.0, 112.0], "value": 84.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 99.0, 135.0, 86.0, 89.0, 88.0, 89.0, 75.0, 136.0, 135.0], "value": 102.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 145.0, 95.0, 143.0, 152.0, 96.0, 97.0, 117.0, 155.0, 111.0], "value": 120.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 121.0, 142.0, 152.0, 89.0, 88.0, 92.0, 89.0, 91.0, 94.0], "value": 106.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 58.0, 54.0, 56.0, 56.0, 58.0, 57.0, 56.0, 56.0], "value": 56.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 83.0, 62.0, 70.0, 102.0, 107.0, 101.0, 101.0, 88.0], "value": 85.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 87.0, 90.0, 89.0, 86.0, 87.0, 87.0, 120.0, 88.0], "value": 90.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 138.0, 138.0, 136.0, 135.0, 149.0, 154.0, 127.0, 147.0, 139.0], "value": 140.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 167.0, 169.0, 163.0, 169.0, 164.0, 167.0, 227.0, 225.0, 177.0], "value": 179.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 65.0, 62.0, 60.0, 69.0, 88.0, 84.0, 85.0, 90.0, 67.0], "value": 74.0, "unit": "score"}]}]} 08:15:38 INFO - Return code: 0 08:15:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:15:38 ERROR - # TBPL SUCCESS # 08:15:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:15:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:15:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:15:38 INFO - 2016-05-27 08:15:38.352 screenresolution[1686:11492] starting screenresolution argv=screenresolution get 08:15:38 INFO - 2016-05-27 08:15:38.355 screenresolution[1686:11492] Display 0: 1600x1200x32@60 08:15:38 INFO - 2016-05-27 08:15:38.360 screenresolution[1687:11495] starting screenresolution argv=screenresolution list 08:15:38 INFO - Available Modes on Display 0 08:15:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:15:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:15:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:15:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:15:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:15:38 INFO - Intel Iris: 08:15:38 INFO - Chipset Model: Intel Iris 08:15:38 INFO - Type: GPU 08:15:38 INFO - Bus: Built-In 08:15:38 INFO - VRAM (Dynamic, Max): 1536 MB 08:15:38 INFO - Vendor: Intel (0x8086) 08:15:38 INFO - Device ID: 0x0a2e 08:15:38 INFO - Revision ID: 0x0009 08:15:38 INFO - Displays: 08:15:38 INFO - Display: 08:15:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:15:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:15:38 INFO - Display Serial Number: 1600x1200 60 08:15:38 INFO - Main Display: Yes 08:15:38 INFO - Mirror: Off 08:15:38 INFO - Online: Yes 08:15:38 INFO - Rotation: Supported 08:15:38 INFO - Return code: 0 08:15:38 INFO - Running post-action listener: _resource_record_post_action 08:15:38 INFO - ##### 08:15:38 INFO - ##### Finished run-tests step (success) 08:15:38 INFO - ##### 08:15:38 INFO - Running post-run listener: _resource_record_post_run 08:15:38 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 31493632; Write bytes: 699260928; Read time: 196; Write time: 2020 08:15:38 INFO - TinderboxPrint: CPU usage
54.5% 08:15:38 INFO - TinderboxPrint: I/O read bytes / time
31,493,632 / 196 08:15:38 INFO - TinderboxPrint: I/O write bytes / time
699,260,928 / 2,020 08:15:38 INFO - TinderboxPrint: CPU idle
2,200.3 (45.5%) 08:15:38 INFO - TinderboxPrint: CPU system
974.3 (20.2%) 08:15:38 INFO - TinderboxPrint: CPU user
1,659.2 (34.3%) 08:15:38 INFO - TinderboxPrint: Swap in / out
425,254,912 / 0 08:15:38 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 393863680; Write bytes: 387578880; Read time: 29583; Write time: 847 08:15:38 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 29711872; Write bytes: 298476544; Read time: 181; Write time: 1134 08:15:39 INFO - Running post-run listener: _upload_blobber_files 08:15:39 INFO - Blob upload gear active. 08:15:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:15:39 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 08:15:39 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'] 08:15:39 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 08:15:39 INFO - (blobuploader) - INFO - Open directory for files ... 08:15:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:15:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:15:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:15:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:15:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:15:40 INFO - (blobuploader) - INFO - Done attempting. 08:15:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:15:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:15:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:15:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:15:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:15:41 INFO - (blobuploader) - INFO - Done attempting. 08:15:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:15:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:15:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:15:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:15:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:15:43 INFO - (blobuploader) - INFO - Done attempting. 08:15:43 INFO - (blobuploader) - INFO - Iteration through files over. 08:15:43 INFO - Return code: 0 08:15:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:15:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:15:43 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/67d062da0f6d43928ab8d8a363f9194d2b89cdbb98b27557a5d8e54f741795e2cafe99a979ab051c30af98c968808da46a1582f6094e8a07187ea5f740cd06d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/005381550884174465f9762749ef9878d6e9b7a0e23fce6f0ab0433fab7e6ed263a0b7e76a5cb85482d617ee02e5dc20dced535a4dc5c8f2390c7ccb0b113b76", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/834964d734b4b8095a644dcf6e7dea8bf84deb30a5c10a641ab0f8029143195c02d18e845da383192b53f7a9e9ec42f055611b132ed107e65068b7a6e6264b68"} 08:15:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:15:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:15:43 INFO - Contents: 08:15:43 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/67d062da0f6d43928ab8d8a363f9194d2b89cdbb98b27557a5d8e54f741795e2cafe99a979ab051c30af98c968808da46a1582f6094e8a07187ea5f740cd06d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/005381550884174465f9762749ef9878d6e9b7a0e23fce6f0ab0433fab7e6ed263a0b7e76a5cb85482d617ee02e5dc20dced535a4dc5c8f2390c7ccb0b113b76", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/834964d734b4b8095a644dcf6e7dea8bf84deb30a5c10a641ab0f8029143195c02d18e845da383192b53f7a9e9ec42f055611b132ed107e65068b7a6e6264b68"} 08:15:43 INFO - Running post-run listener: copy_logs_to_upload_dir 08:15:43 INFO - Copying logs to upload dir... 08:15:43 INFO - mkdir: /builds/slave/test/build/upload/logs 08:15:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1300.840228 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 40 secs) (at 2016-05-27 08:15:43.496641) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 08:15:43.502886) ========= 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.BxG5FsD0qR/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.DH41pVV7hp/Listeners TMPDIR=/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/67d062da0f6d43928ab8d8a363f9194d2b89cdbb98b27557a5d8e54f741795e2cafe99a979ab051c30af98c968808da46a1582f6094e8a07187ea5f740cd06d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/005381550884174465f9762749ef9878d6e9b7a0e23fce6f0ab0433fab7e6ed263a0b7e76a5cb85482d617ee02e5dc20dced535a4dc5c8f2390c7ccb0b113b76", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/834964d734b4b8095a644dcf6e7dea8bf84deb30a5c10a641ab0f8029143195c02d18e845da383192b53f7a9e9ec42f055611b132ed107e65068b7a6e6264b68"} build_url:https://queue.taskcluster.net/v1/task/BMi-wQBRQge783nRqNABZw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011066 build_url: 'https://queue.taskcluster.net/v1/task/BMi-wQBRQge783nRqNABZw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/67d062da0f6d43928ab8d8a363f9194d2b89cdbb98b27557a5d8e54f741795e2cafe99a979ab051c30af98c968808da46a1582f6094e8a07187ea5f740cd06d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/005381550884174465f9762749ef9878d6e9b7a0e23fce6f0ab0433fab7e6ed263a0b7e76a5cb85482d617ee02e5dc20dced535a4dc5c8f2390c7ccb0b113b76", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/834964d734b4b8095a644dcf6e7dea8bf84deb30a5c10a641ab0f8029143195c02d18e845da383192b53f7a9e9ec42f055611b132ed107e65068b7a6e6264b68"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 08:15:43.538796) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 08:15:43.539203) ========= 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.BxG5FsD0qR/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.DH41pVV7hp/Listeners TMPDIR=/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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.005217 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 08:15:43.588738) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 08:15:43.589192) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 08:15:43.589643) ========= ========= Total master_lag: 0.19 =========