builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0040 starttime: 1458611465.54 results: success (0) buildid: 20160321172928 builduid: 8628fcff3fda4cefbb90457aeb7bd1d7 revision: 98189434eea16c181df0c7e8d60af76feceaf492 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-21 18:51:05.537254) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-21 18:51:05.537918) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-21 18:51:05.538434) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.OCiyY8XG80/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.1FWPqtKwSM/Listeners TMPDIR=/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/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 /builds/slave/test program finished with exit code 0 elapsedTime=0.006380 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-21 18:51:05.563106) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-21 18:51:05.563467) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-21 18:51:05.580347) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 18:51:05.580782) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.OCiyY8XG80/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.1FWPqtKwSM/Listeners TMPDIR=/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/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.005421 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 18:51:05.629310) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-21 18:51:05.629652) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-21 18:51:05.630072) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 18:51:05.630384) ========= 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.OCiyY8XG80/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.1FWPqtKwSM/Listeners TMPDIR=/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/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-03-21 18:51:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 45.1M=0s 2016-03-21 18:51:05 (45.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.160108 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 18:51:05.806903) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 18:51:05.807508) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.OCiyY8XG80/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.1FWPqtKwSM/Listeners TMPDIR=/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/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.019501 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 18:51:05.857146) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-21 18:51:05.857545) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 98189434eea16c181df0c7e8d60af76feceaf492 --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 98189434eea16c181df0c7e8d60af76feceaf492 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.OCiyY8XG80/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.1FWPqtKwSM/Listeners TMPDIR=/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/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-03-21 18:51:05,929 truncating revision to first 12 chars 2016-03-21 18:51:05,929 Setting DEBUG logging. 2016-03-21 18:51:05,929 attempt 1/10 2016-03-21 18:51:05,929 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/98189434eea1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-21 18:51:07,696 unpacking tar archive at: fx-team-98189434eea1/testing/mozharness/ program finished with exit code 0 elapsedTime=2.005781 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-21 18:51:07.881320) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-21 18:51:07.881724) ========= echo 98189434eea16c181df0c7e8d60af76feceaf492 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'98189434eea16c181df0c7e8d60af76feceaf492'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.OCiyY8XG80/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.1FWPqtKwSM/Listeners TMPDIR=/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/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 98189434eea16c181df0c7e8d60af76feceaf492 program finished with exit code 0 elapsedTime=0.005250 script_repo_revision: '98189434eea16c181df0c7e8d60af76feceaf492' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-21 18:51:07.932116) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-21 18:51:07.932471) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-21 18:51:07.946392) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-03-21 18:51:07.946765) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.OCiyY8XG80/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.1FWPqtKwSM/Listeners TMPDIR=/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/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 18:51:08 INFO - MultiFileLogger online at 20160321 18:51:08 in /builds/slave/test 18:51:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 18:51:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:51:08 INFO - {'append_to_log': False, 18:51:08 INFO - 'base_work_dir': '/builds/slave/test', 18:51:08 INFO - 'blob_upload_branch': 'Fx-Team', 18:51:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:51:08 INFO - 'branch': 'Fx-Team', 18:51:08 INFO - 'buildbot_json_path': 'buildprops.json', 18:51:08 INFO - 'config_files': ('talos/mac_config.py',), 18:51:08 INFO - 'default_actions': ('clobber', 18:51:08 INFO - 'read-buildbot-config', 18:51:08 INFO - 'download-and-extract', 18:51:08 INFO - 'populate-webroot', 18:51:08 INFO - 'create-virtualenv', 18:51:08 INFO - 'install', 18:51:08 INFO - 'run-tests'), 18:51:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:51:08 INFO - 'download_minidump_stackwalk': True, 18:51:08 INFO - 'download_symbols': 'ondemand', 18:51:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:51:08 INFO - 'tooltool.py': '/tools/tooltool.py', 18:51:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:51:08 INFO - '/tools/misc-python/virtualenv.py')}, 18:51:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:51:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:51:08 INFO - 'installer_path': 'installer.exe', 18:51:08 INFO - 'log_level': 'info', 18:51:08 INFO - 'log_name': 'talos', 18:51:08 INFO - 'log_to_console': True, 18:51:08 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:51:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:51:08 INFO - 'opt_config_files': (), 18:51:08 INFO - 'pip_index': False, 18:51:08 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:51:08 INFO - 'cmd': ('bash', 18:51:08 INFO - '-c', 18:51:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:51:08 INFO - 'enabled': True, 18:51:08 INFO - 'halt_on_failure': False, 18:51:08 INFO - 'name': 'check_screen_resolution'},), 18:51:08 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:51:08 INFO - 'cmd': ('bash', 18:51:08 INFO - '-c', 18:51:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:51:08 INFO - 'enabled': True, 18:51:08 INFO - 'halt_on_failure': False, 18:51:08 INFO - 'name': 'check_screen_resolution'},), 18:51:08 INFO - 'run_cmd_checks_enabled': True, 18:51:08 INFO - 'sps_profile': False, 18:51:08 INFO - 'sps_profile_interval': 0, 18:51:08 INFO - 'suite': 'dromaeojs', 18:51:08 INFO - 'system_bits': '32', 18:51:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:51:08 INFO - 'title': 't-yosemite-r7-0040', 18:51:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:51:08 INFO - 'use_talos_json': True, 18:51:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:51:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:51:08 INFO - 'work_dir': 'build'} 18:51:08 INFO - ##### 18:51:08 INFO - ##### Running clobber step. 18:51:08 INFO - ##### 18:51:08 INFO - Running pre-action listener: _resource_record_pre_action 18:51:08 INFO - Running main action method: clobber 18:51:08 INFO - rmtree: /builds/slave/test/build 18:51:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:51:09 INFO - Running post-action listener: _resource_record_post_action 18:51:09 INFO - ##### 18:51:09 INFO - ##### Running read-buildbot-config step. 18:51:09 INFO - ##### 18:51:09 INFO - Running pre-action listener: _resource_record_pre_action 18:51:09 INFO - Running main action method: read_buildbot_config 18:51:09 INFO - Using buildbot properties: 18:51:09 INFO - { 18:51:09 INFO - "project": "", 18:51:09 INFO - "product": "firefox", 18:51:09 INFO - "script_repo_revision": "production", 18:51:09 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 18:51:09 INFO - "repository": "", 18:51:09 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 18:51:09 INFO - "buildid": "20160321172928", 18:51:09 INFO - "pgo_build": "False", 18:51:09 INFO - "basedir": "/builds/slave/test", 18:51:09 INFO - "buildnumber": 543, 18:51:09 INFO - "slavename": "t-yosemite-r7-0040", 18:51:09 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 18:51:09 INFO - "platform": "yosemite_r7", 18:51:09 INFO - "scheduler": "tests-fx-team-macosx64-talos", 18:51:09 INFO - "branch": "fx-team", 18:51:09 INFO - "repo_path": "integration/fx-team", 18:51:09 INFO - "revision": "98189434eea16c181df0c7e8d60af76feceaf492", 18:51:09 INFO - "stage_platform": "macosx64", 18:51:09 INFO - "builduid": "8628fcff3fda4cefbb90457aeb7bd1d7", 18:51:09 INFO - "slavebuilddir": "test" 18:51:09 INFO - } 18:51:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 18:51:09 INFO - Running post-action listener: _resource_record_post_action 18:51:09 INFO - ##### 18:51:09 INFO - ##### Running download-and-extract step. 18:51:09 INFO - ##### 18:51:09 INFO - Running pre-action listener: _resource_record_pre_action 18:51:09 INFO - Running main action method: download_and_extract 18:51:09 INFO - mkdir: /builds/slave/test/build/tests 18:51:09 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')]} 18:51:09 INFO - https://queue.taskcluster.net/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 18:51:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 18:51:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 18:51:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 18:51:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 18:51:10 INFO - Downloaded 1199 bytes. 18:51:10 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 18:51:10 INFO - Using the following test package requirements: 18:51:10 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 18:51:10 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:51:10 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 18:51:10 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:51:10 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 18:51:10 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:51:10 INFO - u'jsshell-mac.zip'], 18:51:10 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:51:10 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 18:51:10 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 18:51:10 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:51:10 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 18:51:10 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:51:10 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 18:51:10 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:51:10 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 18:51:10 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:51:10 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 18:51:10 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:51:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:51:10 INFO - https://queue.taskcluster.net/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:51:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:51:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:51:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:51:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:51:11 INFO - Downloaded 17858441 bytes. 18:51:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:51:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 18:51:14 INFO - Return code: 0 18:51:14 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 18:51:14 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')]} 18:51:14 INFO - https://queue.taskcluster.net/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:51:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:51:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:51:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:51:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:51:15 INFO - Downloaded 17858441 bytes. 18:51:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:51:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 18:51:19 INFO - Return code: 0 18:51:19 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')]} 18:51:19 INFO - https://queue.taskcluster.net/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 18:51:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 18:51:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 18:51:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 18:51:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 18:51:20 INFO - Downloaded 10847637 bytes. 18:51:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:51:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 18:51:20 INFO - Return code: 0 18:51:20 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')]} 18:51:20 INFO - https://queue.taskcluster.net/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 18:51:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 18:51:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 18:51:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 18:51:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 18:51:23 INFO - Downloaded 111258428 bytes. 18:51:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 18:51:23 INFO - mkdir: /builds/slave/test/properties 18:51:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:51:23 INFO - Writing to file /builds/slave/test/properties/build_url 18:51:23 INFO - Contents: 18:51:23 INFO - build_url:https://queue.taskcluster.net/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 18:51:25 INFO - Running post-action listener: _resource_record_post_action 18:51:25 INFO - Running post-action listener: set_extra_try_arguments 18:51:25 INFO - ##### 18:51:25 INFO - ##### Running populate-webroot step. 18:51:25 INFO - ##### 18:51:25 INFO - Running pre-action listener: _resource_record_pre_action 18:51:25 INFO - Running main action method: populate_webroot 18:51:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:51:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:51:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:51:25 INFO - '--tppagecycles', 18:51:25 INFO - '7'], 18:51:25 INFO - 'tests': ['tsvgm']}}, 18:51:25 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:51:25 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:51:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:51:25 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 18:51:25 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:51:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:51:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:51:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:51:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:51:25 INFO - 'talos_options': ['--e10s'], 18:51:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:51:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:51:25 INFO - 'tests': ['damp', 'tps']}, 18:51:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:51:25 INFO - 'talos_options': ['--e10s'], 18:51:25 INFO - 'tests': ['damp', 'tps']}, 18:51:25 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:51:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:51:25 INFO - 'other': {'tests': ['a11yr', 18:51:25 INFO - 'ts_paint', 18:51:25 INFO - 'tpaint', 18:51:25 INFO - 'sessionrestore', 18:51:25 INFO - 'sessionrestore_no_auto_restore', 18:51:25 INFO - 'tabpaint']}, 18:51:25 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:51:25 INFO - 'tests': ['a11yr', 18:51:25 INFO - 'ts_paint', 18:51:25 INFO - 'tpaint', 18:51:25 INFO - 'sessionrestore', 18:51:25 INFO - 'sessionrestore_no_auto_restore', 18:51:25 INFO - 'tabpaint']}, 18:51:25 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:51:25 INFO - 'tests': ['a11yr', 18:51:25 INFO - 'ts_paint', 18:51:25 INFO - 'tpaint', 18:51:25 INFO - 'sessionrestore', 18:51:25 INFO - 'sessionrestore_no_auto_restore', 18:51:25 INFO - 'tabpaint']}, 18:51:25 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:51:25 INFO - 'tests': ['a11yr', 18:51:25 INFO - 'ts_paint', 18:51:25 INFO - 'tpaint', 18:51:25 INFO - 'sessionrestore', 18:51:25 INFO - 'sessionrestore_no_auto_restore', 18:51:25 INFO - 'tabpaint']}, 18:51:25 INFO - 'other_l64': {'tests': ['a11yr', 18:51:25 INFO - 'ts_paint', 18:51:25 INFO - 'tpaint', 18:51:25 INFO - 'sessionrestore', 18:51:25 INFO - 'sessionrestore_no_auto_restore', 18:51:25 INFO - 'tabpaint']}, 18:51:25 INFO - 'other_nol64': {'tests': ['a11yr', 18:51:25 INFO - 'ts_paint', 18:51:25 INFO - 'tpaint', 18:51:25 INFO - 'sessionrestore', 18:51:25 INFO - 'sessionrestore_no_auto_restore', 18:51:25 INFO - 'tabpaint']}, 18:51:25 INFO - 'svgr': {'tests': ['tsvgx', 18:51:25 INFO - 'tsvgr_opacity', 18:51:25 INFO - 'tart', 18:51:25 INFO - 'tscrollx', 18:51:25 INFO - 'cart']}, 18:51:25 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:51:25 INFO - 'tests': ['tsvgx', 18:51:25 INFO - 'tsvgr_opacity', 18:51:25 INFO - 'tart', 18:51:25 INFO - 'tscrollx', 18:51:25 INFO - 'cart']}, 18:51:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:51:25 INFO - 'tests': ['tp5o']}, 18:51:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:51:25 INFO - 'talos_options': ['--e10s'], 18:51:25 INFO - 'tests': ['tp5o']}, 18:51:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:51:25 INFO - 'talos_options': ['--xperf_path', 18:51:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:51:25 INFO - 'tests': ['tp5n']}, 18:51:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:51:25 INFO - 'talos_options': ['--e10s', 18:51:25 INFO - '--xperf_path', 18:51:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:51:25 INFO - 'tests': ['tp5n']}}, 18:51:25 INFO - 'talos.zip': {'path': '', 18:51:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:51:25 INFO - Running post-action listener: _resource_record_post_action 18:51:25 INFO - ##### 18:51:25 INFO - ##### Running create-virtualenv step. 18:51:25 INFO - ##### 18:51:25 INFO - Running pre-action listener: _resource_record_pre_action 18:51:25 INFO - Running main action method: create_virtualenv 18:51:25 INFO - Creating virtualenv /builds/slave/test/build/venv 18:51:25 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 18:51:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:51:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:51:25 INFO - Using real prefix '/tools/python27' 18:51:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:51:26 INFO - Installing distribute.............................................................................................................................................................................................done. 18:51:28 INFO - Installing pip.................done. 18:51:28 INFO - Return code: 0 18:51:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:51:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:51:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:51:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:51:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:28 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 0x10321aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10322a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1c84b6ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030b9e00>, '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 0x102ee2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1030b4b20>, '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.OCiyY8XG80/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.1FWPqtKwSM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/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 18:51:28 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 18:51:28 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 18:51:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OCiyY8XG80/Render', 18:51:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:51:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:51:28 INFO - 'HOME': '/Users/cltbld', 18:51:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:51:28 INFO - 'LOGNAME': 'cltbld', 18:51:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:28 INFO - 'MOZ_NO_REMOTE': '1', 18:51:28 INFO - 'NO_EM_RESTART': '1', 18:51:28 INFO - 'PAGER': '/bin/cat', 18:51:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:51:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:51:28 INFO - 'PWD': '/builds/slave/test', 18:51:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:51:28 INFO - 'SHELL': '/bin/bash', 18:51:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1FWPqtKwSM/Listeners', 18:51:28 INFO - 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', 18:51:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:51:28 INFO - 'USER': 'cltbld', 18:51:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:51:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:51:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:28 INFO - 'XPC_FLAGS': '0x0', 18:51:28 INFO - 'XPC_SERVICE_NAME': '0', 18:51:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:51:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:51:29 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 18:51:29 INFO - Cleaning up... 18:51:29 INFO - Return code: 0 18:51:29 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:51:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:51:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:51:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10321aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10322a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1c84b6ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030b9e00>, '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 0x102ee2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1030b4b20>, '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.OCiyY8XG80/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.1FWPqtKwSM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/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 18:51:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 18:51:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 18:51:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OCiyY8XG80/Render', 18:51:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:51:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:51:29 INFO - 'HOME': '/Users/cltbld', 18:51:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:51:29 INFO - 'LOGNAME': 'cltbld', 18:51:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:29 INFO - 'MOZ_NO_REMOTE': '1', 18:51:29 INFO - 'NO_EM_RESTART': '1', 18:51:29 INFO - 'PAGER': '/bin/cat', 18:51:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:51:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:51:29 INFO - 'PWD': '/builds/slave/test', 18:51:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:51:29 INFO - 'SHELL': '/bin/bash', 18:51:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1FWPqtKwSM/Listeners', 18:51:29 INFO - 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', 18:51:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:51:29 INFO - 'USER': 'cltbld', 18:51:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:51:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:51:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:29 INFO - 'XPC_FLAGS': '0x0', 18:51:29 INFO - 'XPC_SERVICE_NAME': '0', 18:51:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:51:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:51:29 INFO - Downloading/unpacking psutil>=0.7.1 18:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:51:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:51:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:51:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:51:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:51:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:51:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:51:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:51:31 INFO - Installing collected packages: psutil 18:51:31 INFO - Running setup.py install for psutil 18:51:32 INFO - building 'psutil._psutil_osx' extension 18:51:32 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 18:51:32 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 18:51:32 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 18:51:32 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 18:51:32 INFO - building 'psutil._psutil_posix' extension 18:51:32 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 18:51:32 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:51:32 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:51:32 INFO - ^ 18:51:32 INFO - 1 warning generated. 18:51:32 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 18:51:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:51:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:51:32 INFO - Successfully installed psutil 18:51:32 INFO - Cleaning up... 18:51:32 INFO - Return code: 0 18:51:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:51:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:51:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:51:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:51:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:51:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10321aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10322a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1c84b6ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030b9e00>, '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 0x102ee2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1030b4b20>, '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.OCiyY8XG80/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.1FWPqtKwSM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/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 18:51:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 18:51:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 18:51:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OCiyY8XG80/Render', 18:51:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:51:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:51:32 INFO - 'HOME': '/Users/cltbld', 18:51:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:51:32 INFO - 'LOGNAME': 'cltbld', 18:51:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:32 INFO - 'MOZ_NO_REMOTE': '1', 18:51:32 INFO - 'NO_EM_RESTART': '1', 18:51:32 INFO - 'PAGER': '/bin/cat', 18:51:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:51:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:51:32 INFO - 'PWD': '/builds/slave/test', 18:51:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:51:32 INFO - 'SHELL': '/bin/bash', 18:51:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1FWPqtKwSM/Listeners', 18:51:32 INFO - 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', 18:51:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:51:32 INFO - 'USER': 'cltbld', 18:51:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:51:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:51:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:32 INFO - 'XPC_FLAGS': '0x0', 18:51:32 INFO - 'XPC_SERVICE_NAME': '0', 18:51:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:51:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:51:33 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:51:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:51:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:51:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:51:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:51:35 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:51:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:51:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:51:35 INFO - Installing collected packages: mozsystemmonitor 18:51:35 INFO - Running setup.py install for mozsystemmonitor 18:51:35 INFO - Successfully installed mozsystemmonitor 18:51:35 INFO - Cleaning up... 18:51:35 INFO - Return code: 0 18:51:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:51:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 18:51:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:51:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 18:51:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:51:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:35 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 0x10321aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10322a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1c84b6ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030b9e00>, '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 0x102ee2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1030b4b20>, '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.OCiyY8XG80/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.1FWPqtKwSM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/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 18:51:35 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 18:51:35 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 18:51:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OCiyY8XG80/Render', 18:51:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:51:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:51:35 INFO - 'HOME': '/Users/cltbld', 18:51:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:51:35 INFO - 'LOGNAME': 'cltbld', 18:51:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:35 INFO - 'MOZ_NO_REMOTE': '1', 18:51:35 INFO - 'NO_EM_RESTART': '1', 18:51:35 INFO - 'PAGER': '/bin/cat', 18:51:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:51:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:51:35 INFO - 'PWD': '/builds/slave/test', 18:51:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:51:35 INFO - 'SHELL': '/bin/bash', 18:51:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1FWPqtKwSM/Listeners', 18:51:35 INFO - 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', 18:51:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:51:35 INFO - 'USER': 'cltbld', 18:51:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:51:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:51:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:35 INFO - 'XPC_FLAGS': '0x0', 18:51:35 INFO - 'XPC_SERVICE_NAME': '0', 18:51:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:51:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:51:36 INFO - Downloading/unpacking blobuploader==1.2.4 18:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:51:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:51:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:51:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:51:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:51:38 INFO - Downloading blobuploader-1.2.4.tar.gz 18:51:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:51:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:51:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:51:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:51:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:51:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:51:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:51:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:51:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:51:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:51:39 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 18:51:39 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 18:51:39 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 18:51:39 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 18:51:39 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 18:51:39 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 18:51:39 INFO - Downloading docopt-0.6.1.tar.gz 18:51:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:51:39 INFO - Installing collected packages: blobuploader, requests, docopt 18:51:39 INFO - Running setup.py install for blobuploader 18:51:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:51:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:51:39 INFO - Running setup.py install for requests 18:51:40 INFO - Running setup.py install for docopt 18:51:40 INFO - Successfully installed blobuploader requests docopt 18:51:40 INFO - Cleaning up... 18:51:40 INFO - Return code: 0 18:51:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:51:40 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')]} 18:51:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:51:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:40 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')]} 18:51:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:51:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:40 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 0x10321aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10322a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1c84b6ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030b9e00>, '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 0x102ee2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1030b4b20>, '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.OCiyY8XG80/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.1FWPqtKwSM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/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 18:51:40 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 18:51:40 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 18:51:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OCiyY8XG80/Render', 18:51:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:51:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:51:40 INFO - 'HOME': '/Users/cltbld', 18:51:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:51:40 INFO - 'LOGNAME': 'cltbld', 18:51:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:40 INFO - 'MOZ_NO_REMOTE': '1', 18:51:40 INFO - 'NO_EM_RESTART': '1', 18:51:40 INFO - 'PAGER': '/bin/cat', 18:51:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:51:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:51:40 INFO - 'PWD': '/builds/slave/test', 18:51:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:51:40 INFO - 'SHELL': '/bin/bash', 18:51:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1FWPqtKwSM/Listeners', 18:51:40 INFO - 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', 18:51:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:51:40 INFO - 'USER': 'cltbld', 18:51:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:51:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:51:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:40 INFO - 'XPC_FLAGS': '0x0', 18:51:40 INFO - 'XPC_SERVICE_NAME': '0', 18:51:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:51:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:51:40 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-cj_fR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:51:40 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-LuTAcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:51:40 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-ta1PUV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:51:41 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-rANMFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:51:41 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-SHE77i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:51:41 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-v2T2L5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:51:41 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-thGsxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:51:41 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-jE6XDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:51:41 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-5JbTDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:51:41 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-3Sys_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:51:41 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-HiZxTx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:51:41 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-M1ceVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:51:42 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-AzEiwz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:51:42 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-qyfRXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:51:42 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-MRxhSL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:51:42 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-bmM5uU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:51:42 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-MN6qjD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:51:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:51:42 INFO - Running setup.py install for manifestparser 18:51:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:51:42 INFO - Running setup.py install for mozcrash 18:51:42 INFO - Running setup.py install for mozdebug 18:51:42 INFO - Running setup.py install for mozdevice 18:51:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:51:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:51:43 INFO - Running setup.py install for mozfile 18:51:43 INFO - Running setup.py install for mozhttpd 18:51:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:51:43 INFO - Running setup.py install for mozinfo 18:51:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:51:43 INFO - Running setup.py install for mozInstall 18:51:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:51:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:51:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:51:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:51:43 INFO - Running setup.py install for mozleak 18:51:43 INFO - Running setup.py install for mozlog 18:51:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:51:44 INFO - Running setup.py install for moznetwork 18:51:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:51:44 INFO - Running setup.py install for mozprocess 18:51:44 INFO - Running setup.py install for mozprofile 18:51:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:51:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:51:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:51:44 INFO - Running setup.py install for mozrunner 18:51:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:51:44 INFO - Running setup.py install for mozscreenshot 18:51:44 INFO - Running setup.py install for moztest 18:51:44 INFO - Running setup.py install for mozversion 18:51:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:51:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:51:45 INFO - Cleaning up... 18:51:45 INFO - Return code: 0 18:51:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:51:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 18:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:51:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 18:51:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:51:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:45 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 0x10321aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10322a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1c84b6ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030b9e00>, '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 0x102ee2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1030b4b20>, '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.OCiyY8XG80/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.1FWPqtKwSM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/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 18:51:45 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 18:51:45 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 18:51:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OCiyY8XG80/Render', 18:51:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:51:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:51:45 INFO - 'HOME': '/Users/cltbld', 18:51:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:51:45 INFO - 'LOGNAME': 'cltbld', 18:51:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:45 INFO - 'MOZ_NO_REMOTE': '1', 18:51:45 INFO - 'NO_EM_RESTART': '1', 18:51:45 INFO - 'PAGER': '/bin/cat', 18:51:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:51:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:51:45 INFO - 'PWD': '/builds/slave/test', 18:51:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:51:45 INFO - 'SHELL': '/bin/bash', 18:51:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1FWPqtKwSM/Listeners', 18:51:45 INFO - 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', 18:51:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:51:45 INFO - 'USER': 'cltbld', 18:51:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:51:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:51:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:45 INFO - 'XPC_FLAGS': '0x0', 18:51:45 INFO - 'XPC_SERVICE_NAME': '0', 18:51:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:51:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:51:45 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-AjhsbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:51:45 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)) 18:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:51:45 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-tqGA2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:51:45 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)) 18:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:51:45 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-gtyvoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:51:45 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)) 18:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:51:45 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-7BRLfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:51:45 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)) 18:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:51:45 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-LxYRek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:51:45 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)) 18:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:51:45 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-PtyBNe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:51:45 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)) 18:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:51:45 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-oyqUEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:51:46 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)) 18:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:51:46 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-Q8435X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:51:46 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)) 18:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:51:46 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-cN63Hv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:51:46 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)) 18:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:51:46 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-CQm0Zi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:51:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:51:46 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-h2qnLP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:51:46 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)) 18:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:51:46 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-kEkmHV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:51:46 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)) 18:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:51:46 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-DvJPOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:51:46 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)) 18:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:51:46 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-osgp_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:51:46 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)) 18:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:51:46 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-R_WJ_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:51:46 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)) 18:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:51:46 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-KARnO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:51:47 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)) 18:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:51:47 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-MS2E5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:51:47 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)) 18:51:47 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)) 18:51:47 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)) 18:51:47 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)) 18:51:47 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)) 18:51:47 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)) 18:51:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:51:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:51:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:51:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:51:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:51:49 INFO - Downloading blessings-1.6.tar.gz 18:51:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:51:49 INFO - Installing collected packages: blessings 18:51:49 INFO - Running setup.py install for blessings 18:51:49 INFO - Successfully installed blessings 18:51:49 INFO - Cleaning up... 18:51:49 INFO - Return code: 0 18:51:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:51:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:51:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:51:50 INFO - Reading from file tmpfile_stdout 18:51:50 INFO - Current package versions: 18:51:50 INFO - blessings == 1.6 18:51:50 INFO - blobuploader == 1.2.4 18:51:50 INFO - docopt == 0.6.1 18:51:50 INFO - manifestparser == 1.1 18:51:50 INFO - mozInstall == 1.12 18:51:50 INFO - mozcrash == 0.17 18:51:50 INFO - mozdebug == 0.1 18:51:50 INFO - mozdevice == 0.48 18:51:50 INFO - mozfile == 1.2 18:51:50 INFO - mozhttpd == 0.7 18:51:50 INFO - mozinfo == 0.9 18:51:50 INFO - mozleak == 0.1 18:51:50 INFO - mozlog == 3.1 18:51:50 INFO - moznetwork == 0.27 18:51:50 INFO - mozprocess == 0.22 18:51:50 INFO - mozprofile == 0.28 18:51:50 INFO - mozrunner == 6.11 18:51:50 INFO - mozscreenshot == 0.1 18:51:50 INFO - mozsystemmonitor == 0.0 18:51:50 INFO - moztest == 0.7 18:51:50 INFO - mozversion == 1.4 18:51:50 INFO - psutil == 3.1.1 18:51:50 INFO - requests == 1.2.3 18:51:50 INFO - wsgiref == 0.1.2 18:51:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:51: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')]} 18:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:51:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51: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')]} 18:51:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:51:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:50 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 0x10321aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10322a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1c84b6ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030b9e00>, '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 0x102ee2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1030b4b20>, '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.OCiyY8XG80/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.1FWPqtKwSM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/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 18:51:50 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 18:51:50 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 18:51:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OCiyY8XG80/Render', 18:51:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:51:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:51:50 INFO - 'HOME': '/Users/cltbld', 18:51:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:51:50 INFO - 'LOGNAME': 'cltbld', 18:51:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:50 INFO - 'MOZ_NO_REMOTE': '1', 18:51:50 INFO - 'NO_EM_RESTART': '1', 18:51:50 INFO - 'PAGER': '/bin/cat', 18:51:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:51:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:51:50 INFO - 'PWD': '/builds/slave/test', 18:51:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:51:50 INFO - 'SHELL': '/bin/bash', 18:51:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1FWPqtKwSM/Listeners', 18:51:50 INFO - 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', 18:51:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:51:50 INFO - 'USER': 'cltbld', 18:51:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:51:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:51:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:50 INFO - 'XPC_FLAGS': '0x0', 18:51:50 INFO - 'XPC_SERVICE_NAME': '0', 18:51:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:51:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:51:50 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)) 18:51:50 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)) 18:51:50 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)) 18:51:50 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)) 18:51:50 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)) 18:51:50 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)) 18:51:50 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)) 18:51:50 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)) 18:51:50 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)) 18:51:50 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)) 18:51:50 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)) 18:51:50 INFO - Cleaning up... 18:51:50 INFO - Return code: 0 18:51:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:51: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')]} 18:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:51:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51: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')]} 18:51:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:51:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:50 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 0x10321aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10322a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1c84b6ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030b9e00>, '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 0x102ee2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1030b4b20>, '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.OCiyY8XG80/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.1FWPqtKwSM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/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 18:51:50 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 18:51:50 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 18:51:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OCiyY8XG80/Render', 18:51:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:51:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:51:50 INFO - 'HOME': '/Users/cltbld', 18:51:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:51:50 INFO - 'LOGNAME': 'cltbld', 18:51:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:50 INFO - 'MOZ_NO_REMOTE': '1', 18:51:50 INFO - 'NO_EM_RESTART': '1', 18:51:50 INFO - 'PAGER': '/bin/cat', 18:51:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:51:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:51:50 INFO - 'PWD': '/builds/slave/test', 18:51:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:51:50 INFO - 'SHELL': '/bin/bash', 18:51:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1FWPqtKwSM/Listeners', 18:51:50 INFO - 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', 18:51:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:51:50 INFO - 'USER': 'cltbld', 18:51:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:51:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:51:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:50 INFO - 'XPC_FLAGS': '0x0', 18:51:50 INFO - 'XPC_SERVICE_NAME': '0', 18:51:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:51:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:51:50 INFO - Downloading/unpacking jsonschema 18:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:51:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:51:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:51:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:51:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:51:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:51:53 INFO - Downloading/unpacking functools32 (from jsonschema) 18:51:53 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 18:51:53 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 18:51:53 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 18:51:53 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 18:51:53 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 18:51:53 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 18:51:53 INFO - Downloading functools32-3.2.3-2.tar.gz 18:51:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:51:53 INFO - warning: no files found matching '*.txt' 18:51:53 INFO - no previously-included directories found matching 'build' 18:51:53 INFO - no previously-included directories found matching 'dist' 18:51:53 INFO - no previously-included directories found matching '.git*' 18:51:53 INFO - Installing collected packages: jsonschema, functools32 18:51:53 INFO - Running setup.py install for functools32 18:51:53 INFO - warning: no files found matching '*.txt' 18:51:53 INFO - no previously-included directories found matching 'build' 18:51:53 INFO - no previously-included directories found matching 'dist' 18:51:53 INFO - no previously-included directories found matching '.git*' 18:51:53 INFO - Successfully installed jsonschema functools32 18:51:53 INFO - Cleaning up... 18:51:53 INFO - Return code: 0 18:51:53 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:51:53 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')]} 18:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:51:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:53 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')]} 18:51:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:51:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:53 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 0x10321aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10322a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1c84b6ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030b9e00>, '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 0x102ee2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1030b4b20>, '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.OCiyY8XG80/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.1FWPqtKwSM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/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 18:51:53 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 18:51:53 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 18:51:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OCiyY8XG80/Render', 18:51:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:51:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:51:53 INFO - 'HOME': '/Users/cltbld', 18:51:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:51:53 INFO - 'LOGNAME': 'cltbld', 18:51:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:53 INFO - 'MOZ_NO_REMOTE': '1', 18:51:53 INFO - 'NO_EM_RESTART': '1', 18:51:53 INFO - 'PAGER': '/bin/cat', 18:51:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:51:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:51:53 INFO - 'PWD': '/builds/slave/test', 18:51:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:51:53 INFO - 'SHELL': '/bin/bash', 18:51:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1FWPqtKwSM/Listeners', 18:51:53 INFO - 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', 18:51:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:51:53 INFO - 'USER': 'cltbld', 18:51:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:51:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:51:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:53 INFO - 'XPC_FLAGS': '0x0', 18:51:53 INFO - 'XPC_SERVICE_NAME': '0', 18:51:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:51:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:51:54 INFO - Downloading/unpacking flake8 18:51:54 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 18:51:54 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 18:51:54 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 18:51:54 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 18:51:54 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 18:51:54 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 18:51:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:51:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:51:56 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 18:51:56 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 18:51:56 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 18:51:56 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 18:51:56 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 18:51:56 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 18:51:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:51:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:51:56 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 18:51:56 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 18:51:56 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 18:51:56 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 18:51:56 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 18:51:56 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 18:51:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:51:57 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 18:51:57 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 18:51:57 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 18:51:57 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 18:51:57 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 18:51:57 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 18:51:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:51:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:51:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:51:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:51:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:51:57 INFO - no previously-included directories found matching 'docs/_build' 18:51:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:51:57 INFO - Running setup.py install for pep8 18:51:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:51:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:51:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:51:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:51:58 INFO - no previously-included directories found matching 'docs/_build' 18:51:58 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:51:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:51:58 INFO - Cleaning up... 18:51:58 INFO - Return code: 0 18:51:58 INFO - Running post-action listener: _resource_record_post_action 18:51:58 INFO - Running post-action listener: _start_resource_monitoring 18:51:58 INFO - Starting resource monitoring. 18:51:58 INFO - ##### 18:51:58 INFO - ##### Running install step. 18:51:58 INFO - ##### 18:51:58 INFO - Running pre-action listener: _resource_record_pre_action 18:51:58 INFO - Running main action method: install 18:51:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:51:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:51:58 INFO - Reading from file tmpfile_stdout 18:51:58 INFO - Detecting whether we're running mozinstall >=1.0... 18:51:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:51:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:51:58 INFO - Reading from file tmpfile_stdout 18:51:58 INFO - Output received: 18:51:58 INFO - Usage: mozinstall [options] installer 18:51:58 INFO - Options: 18:51:58 INFO - -h, --help show this help message and exit 18:51:58 INFO - -d DEST, --destination=DEST 18:51:58 INFO - Directory to install application into. [default: 18:51:58 INFO - "/builds/slave/test"] 18:51:58 INFO - --app=APP Application being installed. [default: firefox] 18:51:58 INFO - mkdir: /builds/slave/test/build/application 18:51:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 18:51:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 18:52:32 INFO - Reading from file tmpfile_stdout 18:52:32 INFO - Output received: 18:52:32 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:52:32 INFO - Running post-action listener: _resource_record_post_action 18:52:32 INFO - ##### 18:52:32 INFO - ##### Running run-tests step. 18:52:32 INFO - ##### 18:52:32 INFO - Running pre-action listener: _resource_record_pre_action 18:52:32 INFO - Running main action method: run_tests 18:52:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:52:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:52:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:52:32 INFO - 2016-03-21 18:52:32.892 screenresolution[1966:26696] starting screenresolution argv=screenresolution get 18:52:32 INFO - 2016-03-21 18:52:32.894 screenresolution[1966:26696] Display 0: 1600x1200x32@60 18:52:32 INFO - 2016-03-21 18:52:32.899 screenresolution[1967:26699] starting screenresolution argv=screenresolution list 18:52:32 INFO - Available Modes on Display 0 18:52:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:52:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:52:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:52:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:52:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:52:33 INFO - Intel Iris: 18:52:33 INFO - Chipset Model: Intel Iris 18:52:33 INFO - Type: GPU 18:52:33 INFO - Bus: Built-In 18:52:33 INFO - VRAM (Dynamic, Max): 1536 MB 18:52:33 INFO - Vendor: Intel (0x8086) 18:52:33 INFO - Device ID: 0x0a2e 18:52:33 INFO - Revision ID: 0x0009 18:52:33 INFO - Displays: 18:52:33 INFO - Display: 18:52:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:52:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:52:33 INFO - Display Serial Number: 1600x1200 60 18:52:33 INFO - Main Display: Yes 18:52:33 INFO - Mirror: Off 18:52:33 INFO - Online: Yes 18:52:33 INFO - Rotation: Supported 18:52:33 INFO - Return code: 0 18:52:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:52:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:52:33 INFO - Python 2.7.3 18:52:33 INFO - Return code: 0 18:52:33 INFO - grabbing minidump binary from tooltool 18:52:33 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')]} 18:52:33 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030b9e00>, '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 0x102ee2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1030b4b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:52:33 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 18:52:33 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 18:52:33 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:52:33 INFO - Return code: 0 18:52:33 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:52:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:52:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:52:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:52:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:52:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:52:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:52:34 INFO - Return code: 0 18:52:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0040', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 18:52:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0040 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 18:52:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OCiyY8XG80/Render', 18:52:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:52:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:52:34 INFO - 'HOME': '/Users/cltbld', 18:52:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:52:34 INFO - 'LOGNAME': 'cltbld', 18:52:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:52:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:52:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:34 INFO - 'MOZ_NO_REMOTE': '1', 18:52:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:52:34 INFO - 'NO_EM_RESTART': '1', 18:52:34 INFO - 'PAGER': '/bin/cat', 18:52:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:52:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:52:34 INFO - 'PWD': '/builds/slave/test', 18:52:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:52:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:52:34 INFO - 'SHELL': '/bin/bash', 18:52:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1FWPqtKwSM/Listeners', 18:52:34 INFO - 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', 18:52:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:52:34 INFO - 'USER': 'cltbld', 18:52:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:52:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:52:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:34 INFO - 'XPC_FLAGS': '0x0', 18:52:34 INFO - 'XPC_SERVICE_NAME': '0', 18:52:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:52:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0040', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 18:52:34 INFO - mozversion application_buildid: 20160321172928 18:52:34 INFO - mozversion application_changeset: 98189434eea16c181df0c7e8d60af76feceaf492 18:52:34 INFO - mozversion application_display_name: Nightly 18:52:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:52:34 INFO - mozversion application_name: Firefox 18:52:34 INFO - mozversion application_remotingname: firefox 18:52:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:52:34 INFO - mozversion application_vendor: Mozilla 18:52:34 INFO - mozversion application_version: 48.0a1 18:52:34 INFO - mozversion platform_buildid: 20160321172928 18:52:34 INFO - mozversion platform_changeset: 98189434eea16c181df0c7e8d60af76feceaf492 18:52:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:52:34 INFO - mozversion platform_version: 48.0a1 18:52:34 INFO - using testdate: 1458611554 18:52:34 INFO - actual date: 1458611554 18:52:34 INFO - starting webserver on 'localhost:51874' 18:52:34 INFO - SUITE-START | Running 2 tests 18:52:34 INFO - TEST-START | dromaeo_css 18:52:34 INFO - operating with platform_type : mac_ 18:52:34 INFO - Initialising browser for dromaeo_css test... 18:52:34 INFO - TEST-INFO | started process 1985 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/tmpJHhYtt/profile http://localhost:51874/getInfo.html) 18:52:36 INFO - PROCESS | 1985 | __metrics Screen width/height:1600/1200 18:52:36 INFO - PROCESS | 1985 | colorDepth:24 18:52:36 INFO - PROCESS | 1985 | Browser inner width/height: 1024/689 18:52:36 INFO - PROCESS | 1985 | __metrics 18:52:37 INFO - PROCESS | 1985 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:52:37 ERROR - PROCESS | 1985 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:52:37 INFO - TEST-INFO | 1985: exit 0 18:52:37 INFO - Browser initialized. 18:52:37 INFO - Running cycle 1/1 for dromaeo_css test... 18:52:37 INFO - TEST-INFO | started process 1988 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/tmpJHhYtt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:52:49 INFO - PROCESS | 1988 | RSS: Main: 245579776 18:52:49 INFO - PROCESS | 1988 | 18:53:40 INFO - PROCESS | 1988 | 1458611620703 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] 18:55:50 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:51874/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51874/tests/dromaeo/cssquery-ext.html) 18:55:52 INFO - PROCESS | 1988 | RSS: Main: 416501760 18:55:52 INFO - PROCESS | 1988 | 18:58:55 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:51874/tests/dromaeo/cssquery-ext.html (next: http://localhost:51874/tests/dromaeo/cssquery-jquery.html) 18:58:56 INFO - PROCESS | 1988 | RSS: Main: 380649472 18:58:56 INFO - PROCESS | 1988 | 19:01:58 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:51874/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51874/tests/dromaeo/cssquery-mootools.html) 19:01:58 INFO - PROCESS | 1988 | RSS: Main: 373264384 19:01:58 INFO - PROCESS | 1988 | 19:05:00 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:51874/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51874/tests/dromaeo/cssquery-prototype.html) 19:05:01 INFO - PROCESS | 1988 | RSS: Main: 336859136 19:05:01 INFO - PROCESS | 1988 | 19:08:04 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:51874/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51874/tests/dromaeo/cssquery-yui.html) 19:08:05 INFO - PROCESS | 1988 | RSS: Main: 336257024 19:08:05 INFO - PROCESS | 1988 | 19:11:07 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:51874/tests/dromaeo/cssquery-yui.html (next: http://localhost:51874/tests/dromaeo/cssquery-dojo.html) 19:11:08 INFO - PROCESS | 1988 | RSS: Main: 399941632 19:11:08 INFO - PROCESS | 1988 | 19:11:08 INFO - PROCESS | 1988 | __start_tp_report 19:11:08 INFO - PROCESS | 1988 | _x_x_mozilla_page_load 19:11:08 INFO - PROCESS | 1988 | _x_x_mozilla_page_load_details 19:11:08 INFO - PROCESS | 1988 | |i|pagename|runs| 19:11:08 INFO - PROCESS | 1988 | |0;dojo.html;2916.679165291818;3452.2750222453283;3481.495183198438;3484.442489201727;3541.8583256669735;5565.165225216219;5612.719364031792;5613.522850557702;5640.182173584828;5648.152777083439;5616.101423772197;5695.515881150107;5707.457791509811;5795.565332600061;5803.1875537424685;5075.441701412841;5110.872228194297;5122.923156152642;5135.6918584885025;5242;5272.077386457355;5278.234655974881;5278.445763194867;5325.227841962913;5328.893422131555;5108.514691104339;5110.514501122388;5176.637635365526;5199.1161502544655;5222.556082732972;5169.0954083035695;5174.818881339173;5183.481651834824;5186.962607478482;5225.712585807779;5103.923441148386;5113.2330150477355;5116.641835071509;5150.356205474316;5159.22611608258;5484.040292948718;5568.136938774496;5620.606557540974;5621.550275977912;5629.690367029812;6059.7635868081115;6062.964237789503;6091.355349036975;6095.251420376481;6108;6273.592216505913;6288.402601752826;6321.557490975633;6328.588641738318;6333.936660633381;5705;5777.711114444303;5782.595218334718;5782.884342313172;5806.216160818235;6188.907166392508;6212.689365531705;6229.4393504584805;6261.686915654199;6281.246250449975;5892.499137573354;5895.35151133375;5920.993431116721;5922.318933322636;5959.255093113361;5965.28416590012;6039.909401358896;6060.969695151496;6077.088436734525;6101.664408457489;6061.636301821904;6106.005662907935;6128.938710612926;6158;6190.845228869224;6197.1324014637985;6207.596506227081;6211.472024877846;6215.471684906834;6221.5333849961435;4890.462049174659;4890.755462226874;4892.535209155125;4909.926351104737;4960.90078198434;4298.075913678574;4354.433923589913;4421.336799480104;4452.532484089189;4498.167838949805;5677.574181936371;5687.488126068591;5691.4877661010705;5697.572682048863;5715.657060576379;5926.851828704231;6221.720022598994;6305.936940630535;6332.715027823759;6335.986242201226;5547.2511210986;5599.776008959678;5607.074832652566;5697.658140511582;5725.885482290331;5318;5333.2266821310695;5338.91991620126;5340.172273297645;5341.439148889311;6280.811575652738;6291.02489114188;6304.306526282014;6309.526785491106;6319.684015799284;5303.973480132575;6139.969300153471;6176.9073463897175;6222.471089957223;6331.5251356147555;6251.124842521959;6302.590331628429;6311;6319.304876463493;6334.334894835976;5567.498925096761;5986.862496125722;6129.1112788644505;6154.476869465966;6156.26124865019;5305.734713264244;6108.786192483241;6178.567500275118;6179.752809887555;6271.62370257786;5894.351621321737;6060.636361818305;6067.180930574316;6074.210352654127;6077.6353418795015;6034.456898879122;6036.8188954331445;6040.305364883095;6045.939540604713;6063.999440092335;5764.827055188351;5828.504577110993;5866.6480011199465;5883.676397798162;5885.529157667462;5377.166539186433;5932.288125424977;5973.731182096903;5980.72083005873;6082.391760824059;5921.555883308855;5925.259342582177;5942.494887934574;5951.851203719942;5958.374370691015 19:11:08 INFO - PROCESS | 1988 | |1;ext.html;463.2379735335371;523.8762853678861;535.7819349484962;601.712335601812;624.051441808451;29053.41893162138;39994.40008399873;40284.19431611366;40371.798141009254;40415.79792101035;41809;42700.57299427005;42736.35895461571;42780;42784.14431711364;8953.77615559613;9596.040395960383;9610.567524461416;9615.230781537495;9620.518974051305;9575.138237558618;9712;9723.513824308757;9728.805423891517;9747.707568772948;9621.374610650286;9652;9658.806823863519;9677.419354838697;9769;9626.951865240699;9743.12311891926;9746.512674366253;9748.658796942109;9755.12203901645;9694.51527423633;9809.558569864374;9833.26250531213;9833.26250531213;9841.212702983745;36588.63411365879;41112;41574.58425415737;41731;41765.79117104426;3297.38998285318;3448.758586898918;3495.528103706018;3616.5117709109195;3868.439076333944;29318;30522.84738576315;30568.388632227452;30680.846595767103;30715.692843071505;2797.860106994642;2816.9295767605768;2844.630198074258;2880.74073333401;2888.494513460136;507114;508849;514827.2586370704;515694;516005;45960.5403945963;46448.5355146451;70491.64754176197;71240;71832;45967;46038;46089.5391046092;46098.078038439045;46200.07599847984;15643.139627320379;15781.28984195714;15800.36798528046;15804.68390632204;15829.920850395674;12678.556250531186;12789.936050319875;12791.168574042658;12802.03984701151;12803.103782735305;14710.705785884222;14946.925265373604;14981.775273370908;14992.400303987719;15065.774013389808;6429.710663020175;6501;6541.247756508063;6573.868522629617;6577.572457790228;1016.6492560066913;1025.876894772632;1049.1134990932649;1054.5728979763207;1088.9292196007234;29215.561766573093;29279.707202927697;29721;30021.249468763457;30040.098797036124;1106.5684383090602;1109.7780443911088;1119.1158984402232;1209.7096696792707;1238.13949305232;14918.328675209425;15152.924235378972;15499.9150059497;16381.426650067191;16580.17099145038;669241;669792;670192;672040;677897;63484;63825.04262436067;63980.68009659922;64026;64067.679661601396;1363.6863521390135;1464.3044553836842;1495.4915328788263;1500.1749038028822;1510.3807438949977;29284.414311714074;29320.560191596716;29930.401391972475;30082.24794380158;30617.693823061483;51457.742711287705;51877.74061129821;52172.73913630407;52234.95530089453;52409;407035;408376;409460;410658;411152;33677.98966031023;33720.49419258762;34427.483587746705;34452.48321275233;34568.82715586406;46146.53853461557;46285;46410;46853;47794.52205477901;37295.06762330963;37448.438273425374;38111.237775244896;38223.80888095542;39338.80330598329;31113.688863111078;33276.83361583177;36438.63561364458;36929.44605830861;36940.81529592335;30792.761399410443;36791.26417471582;37940.241195176495;38043.42934856035;38403.61596384112;32231.35537289288;33447.738838024095;33640.1589960253;33728.325433491686;33796.3240735179;24342.878285608458;24343.634845477685;24413.755862441147;24979.750202498468;25154.496910062062 19:11:08 INFO - PROCESS | 1988 | |2;jquery.html;358.75604588879565;360.97834129952207;368.09999551097576;368.2377478619258;369.15831903260556;19437.805621943775;20205.191792328307;20496;20963.580728385423;21005.894970525125;11854.7629047419;12215.694607634792;12220.816687749668;12231.816522752166;12241.898229159375;4376.89057773555;4885.487023862496;5438.428964958682;5443.591730620219;5471.206675032118;5377.677339359651;5408.296921400232;5436.157395603688;5439.945600544003;5453.2092846537225;5214.06146893559;5429.592780541456;5446.91829622556;5490.396056433789;5492.395836457987;4640.628749700016;5412.972935135299;5459.863503412406;5461.42655021221;5482.862928426801;5180.456052114511;5212.009718153577;5269.077911365495;5269.604779641504;5278.076336641073;13230.66923326915;13551.39018744159;13664.863351366459;13676.452941882313;13707;2047.846411519127;2353.752855950118;2402.783749462557;2431.6474111253947;2829.858507074638;9850.852237216448;9988;9993.550290236957;10269.640562580274;10281.177505799518;1764.9911750441295;1818.4635532517939;1843.3456123076382;1864.5245462407;1903.9714404283948;102303.48848255785;107595.99999999921;107808;108211;108660;11349.60276390339;11434.428278586038;11468.197226194254;11534.307941523535;11626.593069242535;13838.723225535634;13908.791368129487;13941.233232172328;13951;13963.301834908214;8423.189014361818;8577.95711021441;8596.441231319945;8690.391672582859;8695;8693.869591956125;8710.433821801562;8745.12548745133;8822.735317940473;8852.424592401601;4425.22558552252;4507.6619253555455;4512.165249428801;4564.52072532386;4566.429196350457;1687.8059023212488;1778.2264714849082;1849.8705090643796;1909.625069949634;1959.177145598852;857.9699710510228;947.0955237747934;962.2782912815388;963.5086106085946;975.2977855943709;16145;19013.59898482234;20184.69722954157;20281.985900704905;20410.08154633045;889.2485849457198;935.4527601353285;942.830290547708;967.2938754708961;977.2816979520047;9282.90717092834;10633.415162166155;10807.78384432307;10838.566457341776;10842.620508282173;594726;603866;619337;644098;645152;86640.56679716561;98129.50935245278;102247;107008.9299106999;109373;960.490939801906;973.2749101919115;984.9064338887795;986.2701600815345;1008.9041541053441;13590.388432520758;15876.603084922508;17830.10849457496;18304;18583.07084645735;48677.26984095312;50885.74557127191;50992;51603;51885.48114518957;63774.3622563787;66587.66706166438;67066.6646666783;67828.66085669737;68649;6438.67806609677;7548.282913123464;7676.884846727192;7703.422243331885;7788.299053085249;7200.387967022862;10579.682609521727;12346.938265308616;12646.620601381974;12828.807567886675;10098.29311948186;10571.735706607396;10776.784464310827;10876.18428617841;11081.390523521284;9403.952980235055;10620.15038796879;10624.734381640521;10663;11001.559937602406;8804.64781408762;10939.124870010539;11176.88823111791;11206.271592346471;11260.761316255042;7663;7738.226177382442;7766.650500727594;7832.099308579358;8031.357491400557;10327.32872363294;10738.355698658106;10794.73013174677;11065.280756750786;11072.280301780358 19:11:08 INFO - PROCESS | 1988 | |3;mootools.html;1430.7210094031655;1610.685916246332;1641.4829328761439;1760.9911950440246;2052.8563000589957;8012.8798068028955;8618.827623447534;8724.17120373565;8761.167689069529;8774.780630484242;8494.277986371166;8663.436876603033;8684.956575217115;8685.782855428617;8686.174813392718;2207.922722704706;2445.7921076708412;2482.0444129010325;2508.6613307203565;2516.748325167487;2535.8985640574356;2541.072508534381;2542.618607208924;2546.7835234005133;2550.33691240277;2418.770216829407;2504.3613878460965;2504.6994360676745;2507.9749202508015;2517.8363406378617;2436.183878400729;2497.163450244161;2514.6856642919633;2518.8236823422367;2518.9748102518924;2482.6027835546224;2507.774300312962;2518.942044341381;2519.659845920814;2530.9240722778345;8805.42764720291;8877.467351958838;8881.555922203865;8882.11178882113;8897.288216942694;5497.120460726304;5638.689872057035;5641.802536911188;5644.153376993443;5647.068233741427;3625.800580968046;3714.9814250928844;3769.1707824278888;3773.339665558516;3798.1833905710405;1043.5095505112586;1065.5631191211644;1071.8981696738874;1083.7019819549607;1085.0722632149557;11820.763584728344;11843.348615826126;11849.94075029628;11852.933236008801;11887.643370698806;4943.604511639061;4953.851384458472;5056.342675452242;5056.84829455117;5074.11203039474;8714.738557843275;10149.543270552844;10169.440680762482;10177.338472999232;10191.337563058378;5603.6077474577205;5605.775768969277;5610.579206559524;5617.915731264035;5642.520385767174;4487.708298960557;4650.069986002813;4921.483244259372;4980.90038199234;5026.070177017264;3900.902477438087;4008.6793056555407;4026.8187931543152;4039.0508230565792;4074.4295798588223;1323.808047833078;1339.9531016414378;1346.1048402812216;1349.3590544491287;1353.5195005773005;1345.3744009035845;1377.9586612401645;1400.1459109942928;1413.0673755321438;1422.0188070231507;8080.43436959419;8218.342532597379;8283.58582070894;8311.25198732117;8432.241098301183;1140.2531341971023;1177.4289469607234;1237.3380241570717;1241.2862604002735;1249.950001999928;6334.588251763621;6340.873182536416;6422.8715425691225;6431.614103153825;6436.485081193493;10267.589296428208;10625.893741062646;10705.1435885129;10776.892231077745;10785.676429707122;10532.789344213073;10544.420056896792;10651.98806113418;10752.193585480964;10757.677269681923;8167.346612271004;8326.50040997542;8354.164583541718;8413.579321033923;8416.326693864476;7751.341136003277;7888;7911.248431399008;7940.761777146695;7961;9388.061193880558;9486.051394860458;9629.951850240705;9752.317337786571;9756.707298781048;9716.854247186156;9751.951240244038;9883.950580247052;10043.949780251345;10078.395296282246;6886.793396198122;7085.539439936388;7438.367738742268;7542.585157816373;7690.230976902265;8246.257836794717;8308.626111824862;8310.501369917823;8323.542205178774;8346.749597512084;7296.854062918818;7386.96306518464;7404.444666650131;7445.255474452511;7566.962165189138;7206.639668016683;7278.96360518194;7291.4166866649475;7314.743983960536;7342.339189472973;7678.232176782277;7745.612719364122;7751.689932402866;7835.960820196091;7891.526508409514;6050.183225264709;6987.720491180499;6988.895166572607;6990.825229369103;7078;6079.726412311545;7221.494495385273;7222.927770722225;7223.422126229784;7224.89162662571 19:11:08 INFO - PROCESS | 1988 | |4;prototype.html;321.16336942265394;324.89928122282095;328.9391462579421;332.44315771083427;333.75802543156215;6573.309802470743;6592.637404942726;6629.204495460552;6653.4011938925605;6664.500162487809;5478.753456094475;6419.812334718081;6559.147310849595;6587.077809106729;6601.768938087168;4661.067786442708;4783.210770222909;4820.71075735457;4909.962365618264;4914.877128071791;4879.634027447938;4917.262410638397;4920.0159968006365;4920.852374428773;4926.753662316888;4847.369841920546;4858.41698996121;4861.781219845116;4865.781039853215;4866.756662166895;4657.301404789275;4736.881577960578;4744;4767.118083154627;4784.90430191396;4155.688323375759;4169.332906734938;4176.14389050244;4179.164167166578;4182.079942412664;6264.686765661699;6304.338044505307;6360.9045864312075;6381.521385896076;6389.233292004989;5765.1928729977835;5767.163761254595;5771.88456230873;5776.624519406225;5776.740046697909;6756.290589488131;7019.8596028079155;7038.225795162528;7042.225355210922;7049.92950070503;4721.504242054569;4722.693024953367;4732.692374995614;4742.336072949755;4749.762511874393;7251.383632391253;7383.8154046149275;7436.628168591549;7442.776716698508;7470.551766893949;3996.8800935971967;4813.278008298783;4814.229723244334;4818.012307476959;4819.060283244734;4050.675945924319;4855.271709243641;4877.268409738567;4892.877678058077;4908.092002979461;4931.3835770528685;5608.46719561641;5773.8556536086935;5781.624194427349;5787.1319302104175;6733.192016957996;7034.6834392452465;7058.505904586732;7065;7082.291770822876;1668.8748343874258;1701.9149042547824;1711.0332662045905;1711.1957380031365;1714.2971381733678;1095.9287646302964;1107.3466654673782;1115.1636272795404;1128.6501184632625;1132.456420917964;5317.308749862493;6335.11308416822;6441.613503189824;6585.637789921505;6603.339666033358;7339.449541284425;7339.449541284425;7342.889856652155;7355.448341374311;7365.2634736525915;6603.537752357289;6608.4052435281055;6609.438197753148;6609.801705948829;6614.470842332602;3822.636849499293;3869.587600525788;3874.5737968823405;3881.573026967031;3881.6506514413836;7368.078990126234;7630.313271805564;7698.807529811799;7705.9229407706325;7707;7504.549727016397;7543.358814500719;7560.697572097164;7568.470207085451;7569.3566046886635;7626.58053807046;7635.847283054419;7645.617719114133;7673.117591477052;7675.232476752391;7269.890951635835;7297.416206703557;7312.780616581511;7318.194998550049;7327.487075904849;6595.472362211108;6616.610511792577;6857.897131542931;7214.819629509304;7228.421726261991;7141.285871412817;7659.195784442776;7670.348020418104;7674.462787604814;7674.769756907302;4813.109574728686;4820.469748327611;4820.68665536739;4826.0830442215865;4828.589569886599;7257.600831954293;7277.235890231449;7285.380742636935;7289;7299.160596531255;6839.62382068991;6952;7080.716771329089;7106.538075025107;7123.608201548965;7020.403265722471;7048.295170482911;7049.682764275723;7069.858602828018;7078.398336141279;5402.378726446509;6916.654167291716;6918.238993710788;6925.411340036153;6925.515213934977;6789.660516974032;7031.1211098612675;7046.753363632453;7048.224695283618;7059.047028651066;6655.367740064686;6789.966050169717;6892.276310987274;6913.170419549686;6943.618101004493 19:11:08 INFO - PROCESS | 1988 | |5;yui.html;692.5498426023086;746.3357611725562;748.3900620993886;758.2758465665287;762.7826069570174;15301.540953771391;15502.61243468914;15525.456609018687;15532.611684707874;15565.53303400897;12526.686832829184;12538.56115035974;12544.37278136094;12591.811122833165;14083.788743168861;771.8842173673937;779.8752199648058;922.1239822168933;924.7225832250315;938.3994243684048;941.9058094190594;942.7313215733517;945.6170251048336;945.9006804285519;952.0907533305711;985.3693636072883;987.9802403951917;988.85661579071;989.8762654668167;990.5889056041734;801.7755028592004;978.6427953796884;990.2721499697716;993.9155171810332;998.825205589019;736.6390468670367;737.2995654128599;737.7971057959104;737.8634952533798;739.1425945902781;15079.54761357161;15109.773353399598;15126.621834454227;15205.163715995615;15221.695566088727;10851.67444976644;12503.124781265315;12594.496220151183;12661.93669031649;12975.286359250238;9887.90112098877;10139.797204055878;10249.74375640615;10397.376157430503;10633.46832658364;3439.8968030959113;3483.372992861284;3577.266660334625;3598.280343931198;3669.119411341259;74872.625636872;74913.62543187359;74958;75277.87083193756;75285;9438.52807359643;9459.810803784023;9473.810523789623;9512.762180945532;9756.707298781048;21306.78693213079;21392.57214855694;21416.036278367512;21424.892875535523;22346.66480002801;7668.769936901902;7676.270754278335;7835.608219588998;7856;7965.163657815961;4149.91700166001;4205.474315710536;4206.242876282298;4216.9789151054665;4274.038341373166;3662.5421822272215;3700.40793473043;3710.8330125144435;3716.089558058293;3717.9070523236596;583.588570058108;664.4020381656547;675.0380707491804;694.3160986428364;701.1656129206228;493.97283149427125;502.9949700502948;585.3765739487433;623.2085251730367;631.1227393922452;7737.535747855034;8157.265846073882;8239.299659528888;8279.917200828035;8318.66725330992;495.23486213799765;497.2566013809306;593.7773334999375;603.8973374526253;609.6403122157948;3831.63599458051;3846.74996125251;3860.9613903861164;3973.264945985002;4065.3698676705158;83023;85989;86015.70976435358;86233.56883215543;86345.5682721595;72349.63825180946;77893.61053194811;78324.03463515113;78457;78574.607126964;65798.34201658018;69601.65199174175;69606;70748.2925170752;70808.29191708018;7725.613719314124;7821.528830149441;7868.960655196687;7962.522248665098;7982.6008699565955;39301;40033.79983100066;49422;49727.75136124296;50204.74897625635;50713.23930140977;54954.17568736552;69112;69794.30205697878;71534.28465715276;9187.908120918706;9345.953270233606;9977.052180042885;10084.243681724047;10253.692389228336;9848.015198480094;10654.836761167327;10840.078593319657;10902.56389744433;11298.717532061435;10180.694579162637;10288.434136122585;10546.947265263625;10630.043296103388;10709.785804284027;10091.293609447268;10362.689119326433;10365.481725913825;10573.418461984666;11184.608538701106;9996;10056.849147262943;10153.340032897839;10166.847497287694;10174.593016279561;7772.872933424735;8584.871226931726;8881.111888811067;9059;9228.35401521887;7951.522908625501;8115.4319197655595;8635.6977505787;8834.38148872931;8870.2460290876 19:11:08 INFO - PROCESS | 1988 | __end_tp_report 19:11:08 INFO - PROCESS | 1988 | __start_cc_report 19:11:08 INFO - PROCESS | 1988 | _x_x_mozilla_cycle_collect,1655 19:11:08 INFO - PROCESS | 1988 | __end_cc_report 19:11:08 INFO - PROCESS | 1988 | __startTimestamp1458612668200__endTimestamp 19:11:08 INFO - PROCESS | 1988 | 19:11:08 INFO - PROCESS | 1988 | ------- Summary: start ------- 19:11:08 INFO - PROCESS | 1988 | Number of tests: 6 19:11:08 INFO - PROCESS | 1988 | 19:11:08 INFO - PROCESS | 1988 | [#0] dojo.html Cycles:165 Average:5681.90 Median:5883.68 stddev:623.89 (10.6%) stddev-sans-first:586.88 19:11:08 INFO - PROCESS | 1988 | Values: 2916.7 3452.3 3481.5 3484.4 3541.9 5565.2 5612.7 5613.5 5640.2 5648.2 5616.1 5695.5 5707.5 5795.6 5803.2 5075.4 5110.9 5122.9 5135.7 5242.0 5272.1 5278.2 5278.4 5325.2 5328.9 5108.5 5110.5 5176.6 5199.1 5222.6 5169.1 5174.8 5183.5 5187.0 5225.7 5103.9 5113.2 5116.6 5150.4 5159.2 5484.0 5568.1 5620.6 5621.6 5629.7 6059.8 6063.0 6091.4 6095.3 6108.0 6273.6 6288.4 6321.6 6328.6 6333.9 5705.0 5777.7 5782.6 5782.9 5806.2 6188.9 6212.7 6229.4 6261.7 6281.2 5892.5 5895.4 5921.0 5922.3 5959.3 5965.3 6039.9 6061.0 6077.1 6101.7 6061.6 6106.0 6128.9 6158.0 6190.8 6197.1 6207.6 6211.5 6215.5 6221.5 4890.5 4890.8 4892.5 4909.9 4960.9 4298.1 4354.4 4421.3 4452.5 4498.2 5677.6 5687.5 5691.5 5697.6 5715.7 5926.9 6221.7 6305.9 6332.7 6336.0 5547.3 5599.8 5607.1 5697.7 5725.9 5318.0 5333.2 5338.9 5340.2 5341.4 6280.8 6291.0 6304.3 6309.5 6319.7 5304.0 6140.0 6176.9 6222.5 6331.5 6251.1 6302.6 6311.0 6319.3 6334.3 5567.5 5986.9 6129.1 6154.5 6156.3 5305.7 6108.8 6178.6 6179.8 6271.6 5894.4 6060.6 6067.2 6074.2 6077.6 6034.5 6036.8 6040.3 6045.9 6064.0 5764.8 5828.5 5866.6 5883.7 5885.5 5377.2 5932.3 5973.7 5980.7 6082.4 5921.6 5925.3 5942.5 5951.9 5958.4 19:11:08 INFO - PROCESS | 1988 | 19:11:08 INFO - PROCESS | 1988 | [#1] ext.html Cycles:180 Average:66690.47 Median:21603.62 stddev:144972.00 (671.1%) stddev-sans-first:145293.41 19:11:08 INFO - PROCESS | 1988 | Values: 463.2 523.9 535.8 601.7 624.1 29053.4 39994.4 40284.2 40371.8 40415.8 41809.0 42700.6 42736.4 42780.0 42784.1 8953.8 9596.0 9610.6 9615.2 9620.5 9575.1 9712.0 9723.5 9728.8 9747.7 9621.4 9652.0 9658.8 9677.4 9769.0 9627.0 9743.1 9746.5 9748.7 9755.1 9694.5 9809.6 9833.3 9833.3 9841.2 36588.6 41112.0 41574.6 41731.0 41765.8 3297.4 3448.8 3495.5 3616.5 3868.4 29318.0 30522.8 30568.4 30680.8 30715.7 2797.9 2816.9 2844.6 2880.7 2888.5 507114.0 508849.0 514827.3 515694.0 516005.0 45960.5 46448.5 70491.6 71240.0 71832.0 45967.0 46038.0 46089.5 46098.1 46200.1 15643.1 15781.3 15800.4 15804.7 15829.9 12678.6 12789.9 12791.2 12802.0 12803.1 14710.7 14946.9 14981.8 14992.4 15065.8 6429.7 6501.0 6541.2 6573.9 6577.6 1016.6 1025.9 1049.1 1054.6 1088.9 29215.6 29279.7 29721.0 30021.2 30040.1 1106.6 1109.8 1119.1 1209.7 1238.1 14918.3 15152.9 15499.9 16381.4 16580.2 669241.0 669792.0 670192.0 672040.0 677897.0 63484.0 63825.0 63980.7 64026.0 64067.7 1363.7 1464.3 1495.5 1500.2 1510.4 29284.4 29320.6 29930.4 30082.2 30617.7 51457.7 51877.7 52172.7 52235.0 52409.0 407035.0 408376.0 409460.0 410658.0 411152.0 33678.0 33720.5 34427.5 34452.5 34568.8 46146.5 46285.0 46410.0 46853.0 47794.5 37295.1 37448.4 38111.2 38223.8 39338.8 31113.7 33276.8 36438.6 36929.4 36940.8 30792.8 36791.3 37940.2 38043.4 38403.6 32231.4 33447.7 33640.2 33728.3 33796.3 24342.9 24343.6 24413.8 24979.8 25154.5 19:11:08 INFO - PROCESS | 1988 | 19:11:08 INFO - PROCESS | 1988 | [#2] jquery.html Cycles:180 Average:33373.25 Median:368.70 stddev:102777.38 (27875.8%) stddev-sans-first:103035.80 19:11:08 INFO - PROCESS | 1988 | Values: 358.8 361.0 368.1 368.2 369.2 19437.8 20205.2 20496.0 20963.6 21005.9 11854.8 12215.7 12220.8 12231.8 12241.9 4376.9 4885.5 5438.4 5443.6 5471.2 5377.7 5408.3 5436.2 5439.9 5453.2 5214.1 5429.6 5446.9 5490.4 5492.4 4640.6 5413.0 5459.9 5461.4 5482.9 5180.5 5212.0 5269.1 5269.6 5278.1 13230.7 13551.4 13664.9 13676.5 13707.0 2047.8 2353.8 2402.8 2431.6 2829.9 9850.9 9988.0 9993.6 10269.6 10281.2 1765.0 1818.5 1843.3 1864.5 1904.0 102303.5 107596.0 107808.0 108211.0 108660.0 11349.6 11434.4 11468.2 11534.3 11626.6 13838.7 13908.8 13941.2 13951.0 13963.3 8423.2 8578.0 8596.4 8690.4 8695.0 8693.9 8710.4 8745.1 8822.7 8852.4 4425.2 4507.7 4512.2 4564.5 4566.4 1687.8 1778.2 1849.9 1909.6 1959.2 858.0 947.1 962.3 963.5 975.3 16145.0 19013.6 20184.7 20282.0 20410.1 889.2 935.5 942.8 967.3 977.3 9282.9 10633.4 10807.8 10838.6 10842.6 594726.0 603866.0 619337.0 644098.0 645152.0 86640.6 98129.5 102247.0 107008.9 109373.0 960.5 973.3 984.9 986.3 1008.9 13590.4 15876.6 17830.1 18304.0 18583.1 48677.3 50885.7 50992.0 51603.0 51885.5 63774.4 66587.7 67066.7 67828.7 68649.0 6438.7 7548.3 7676.9 7703.4 7788.3 7200.4 10579.7 12346.9 12646.6 12828.8 10098.3 10571.7 10776.8 10876.2 11081.4 9404.0 10620.2 10624.7 10663.0 11001.6 8804.6 10939.1 11176.9 11206.3 11260.8 7663.0 7738.2 7766.7 7832.1 8031.4 10327.3 10738.4 10794.7 11065.3 11072.3 19:11:08 INFO - PROCESS | 1988 | 19:11:08 INFO - PROCESS | 1988 | [#3] mootools.html Cycles:180 Average:6094.87 Median:5285.62 stddev:3148.74 (59.6%) stddev-sans-first:3138.05 19:11:08 INFO - PROCESS | 1988 | Values: 1430.7 1610.7 1641.5 1761.0 2052.9 8012.9 8618.8 8724.2 8761.2 8774.8 8494.3 8663.4 8685.0 8685.8 8686.2 2207.9 2445.8 2482.0 2508.7 2516.7 2535.9 2541.1 2542.6 2546.8 2550.3 2418.8 2504.4 2504.7 2508.0 2517.8 2436.2 2497.2 2514.7 2518.8 2519.0 2482.6 2507.8 2518.9 2519.7 2530.9 8805.4 8877.5 8881.6 8882.1 8897.3 5497.1 5638.7 5641.8 5644.2 5647.1 3625.8 3715.0 3769.2 3773.3 3798.2 1043.5 1065.6 1071.9 1083.7 1085.1 11820.8 11843.3 11849.9 11852.9 11887.6 4943.6 4953.9 5056.3 5056.8 5074.1 8714.7 10149.5 10169.4 10177.3 10191.3 5603.6 5605.8 5610.6 5617.9 5642.5 4487.7 4650.1 4921.5 4980.9 5026.1 3900.9 4008.7 4026.8 4039.1 4074.4 1323.8 1340.0 1346.1 1349.4 1353.5 1345.4 1378.0 1400.1 1413.1 1422.0 8080.4 8218.3 8283.6 8311.3 8432.2 1140.3 1177.4 1237.3 1241.3 1250.0 6334.6 6340.9 6422.9 6431.6 6436.5 10267.6 10625.9 10705.1 10776.9 10785.7 10532.8 10544.4 10652.0 10752.2 10757.7 8167.3 8326.5 8354.2 8413.6 8416.3 7751.3 7888.0 7911.2 7940.8 7961.0 9388.1 9486.1 9630.0 9752.3 9756.7 9716.9 9752.0 9884.0 10043.9 10078.4 6886.8 7085.5 7438.4 7542.6 7690.2 8246.3 8308.6 8310.5 8323.5 8346.7 7296.9 7387.0 7404.4 7445.3 7567.0 7206.6 7279.0 7291.4 7314.7 7342.3 7678.2 7745.6 7751.7 7836.0 7891.5 6050.2 6987.7 6988.9 6990.8 7078.0 6079.7 7221.5 7222.9 7223.4 7224.9 19:11:08 INFO - PROCESS | 1988 | 19:11:08 INFO - PROCESS | 1988 | [#4] prototype.html Cycles:180 Average:5779.63 Median:6594.05 stddev:1827.04 (27.7%) stddev-sans-first:1785.63 19:11:08 INFO - PROCESS | 1988 | Values: 321.2 324.9 328.9 332.4 333.8 6573.3 6592.6 6629.2 6653.4 6664.5 5478.8 6419.8 6559.1 6587.1 6601.8 4661.1 4783.2 4820.7 4910.0 4914.9 4879.6 4917.3 4920.0 4920.9 4926.8 4847.4 4858.4 4861.8 4865.8 4866.8 4657.3 4736.9 4744.0 4767.1 4784.9 4155.7 4169.3 4176.1 4179.2 4182.1 6264.7 6304.3 6360.9 6381.5 6389.2 5765.2 5767.2 5771.9 5776.6 5776.7 6756.3 7019.9 7038.2 7042.2 7049.9 4721.5 4722.7 4732.7 4742.3 4749.8 7251.4 7383.8 7436.6 7442.8 7470.6 3996.9 4813.3 4814.2 4818.0 4819.1 4050.7 4855.3 4877.3 4892.9 4908.1 4931.4 5608.5 5773.9 5781.6 5787.1 6733.2 7034.7 7058.5 7065.0 7082.3 1668.9 1701.9 1711.0 1711.2 1714.3 1095.9 1107.3 1115.2 1128.7 1132.5 5317.3 6335.1 6441.6 6585.6 6603.3 7339.4 7339.4 7342.9 7355.4 7365.3 6603.5 6608.4 6609.4 6609.8 6614.5 3822.6 3869.6 3874.6 3881.6 3881.7 7368.1 7630.3 7698.8 7705.9 7707.0 7504.5 7543.4 7560.7 7568.5 7569.4 7626.6 7635.8 7645.6 7673.1 7675.2 7269.9 7297.4 7312.8 7318.2 7327.5 6595.5 6616.6 6857.9 7214.8 7228.4 7141.3 7659.2 7670.3 7674.5 7674.8 4813.1 4820.5 4820.7 4826.1 4828.6 7257.6 7277.2 7285.4 7289.0 7299.2 6839.6 6952.0 7080.7 7106.5 7123.6 7020.4 7048.3 7049.7 7069.9 7078.4 5402.4 6916.7 6918.2 6925.4 6925.5 6789.7 7031.1 7046.8 7048.2 7059.0 6655.4 6790.0 6892.3 6913.2 6943.6 19:11:08 INFO - PROCESS | 1988 | 19:11:08 INFO - PROCESS | 1988 | [#5] yui.html Cycles:180 Average:17448.25 Median:34902.27 stddev:24405.44 (69.9%) stddev-sans-first:24441.47 19:11:08 INFO - PROCESS | 1988 | Values: 692.5 746.3 748.4 758.3 762.8 15301.5 15502.6 15525.5 15532.6 15565.5 12526.7 12538.6 12544.4 12591.8 14083.8 771.9 779.9 922.1 924.7 938.4 941.9 942.7 945.6 945.9 952.1 985.4 988.0 988.9 989.9 990.6 801.8 978.6 990.3 993.9 998.8 736.6 737.3 737.8 737.9 739.1 15079.5 15109.8 15126.6 15205.2 15221.7 10851.7 12503.1 12594.5 12661.9 12975.3 9887.9 10139.8 10249.7 10397.4 10633.5 3439.9 3483.4 3577.3 3598.3 3669.1 74872.6 74913.6 74958.0 75277.9 75285.0 9438.5 9459.8 9473.8 9512.8 9756.7 21306.8 21392.6 21416.0 21424.9 22346.7 7668.8 7676.3 7835.6 7856.0 7965.2 4149.9 4205.5 4206.2 4217.0 4274.0 3662.5 3700.4 3710.8 3716.1 3717.9 583.6 664.4 675.0 694.3 701.2 494.0 503.0 585.4 623.2 631.1 7737.5 8157.3 8239.3 8279.9 8318.7 495.2 497.3 593.8 603.9 609.6 3831.6 3846.7 3861.0 3973.3 4065.4 83023.0 85989.0 86015.7 86233.6 86345.6 72349.6 77893.6 78324.0 78457.0 78574.6 65798.3 69601.7 69606.0 70748.3 70808.3 7725.6 7821.5 7869.0 7962.5 7982.6 39301.0 40033.8 49422.0 49727.8 50204.7 50713.2 54954.2 69112.0 69794.3 71534.3 9187.9 9346.0 9977.1 10084.2 10253.7 9848.0 10654.8 10840.1 10902.6 11298.7 10180.7 10288.4 10546.9 10630.0 10709.8 10091.3 10362.7 10365.5 10573.4 11184.6 9996.0 10056.8 10153.3 10166.8 10174.6 7772.9 8584.9 8881.1 9059.0 9228.4 7951.5 8115.4 8635.7 8834.4 8870.2 19:11:08 INFO - PROCESS | 1988 | -------- Summary: end -------- 19:11:08 INFO - PROCESS | 1988 | 19:11:08 INFO - TEST-INFO | 1988: exit 0 19:11:08 INFO - TEST-OK | dromaeo_css | took 1114134ms 19:11:08 INFO - TEST-START | kraken 19:11:08 INFO - operating with platform_type : mac_ 19:11:08 INFO - Initialising browser for kraken test... 19:11:08 INFO - TEST-INFO | started process 1992 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/tmpNNogM5/profile http://localhost:51874/getInfo.html) 19:11:10 INFO - PROCESS | 1992 | __metrics Screen width/height:1600/1200 19:11:10 INFO - PROCESS | 1992 | colorDepth:24 19:11:10 INFO - PROCESS | 1992 | Browser inner width/height: 1024/689 19:11:10 INFO - PROCESS | 1992 | __metrics 19:11:11 INFO - PROCESS | 1992 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:11:11 ERROR - PROCESS | 1992 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:11:11 INFO - TEST-INFO | 1992: exit 0 19:11:11 INFO - Browser initialized. 19:11:11 INFO - Running cycle 1/1 for kraken test... 19:11:11 INFO - TEST-INFO | started process 1994 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/tmpNNogM5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:11:23 INFO - PROCESS | 1994 | RSS: Main: 247218176 19:11:23 INFO - PROCESS | 1994 | 19:11:26 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:51874/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51874/tests/kraken/driver.html?testName=audio-beat-detection) 19:11:27 INFO - PROCESS | 1994 | RSS: Main: 291536896 19:11:27 INFO - PROCESS | 1994 | 19:11:29 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:51874/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51874/tests/kraken/driver.html?testName=audio-dft) 19:11:30 INFO - PROCESS | 1994 | RSS: Main: 302604288 19:11:30 INFO - PROCESS | 1994 | 19:11:33 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:51874/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51874/tests/kraken/driver.html?testName=audio-fft) 19:11:34 INFO - PROCESS | 1994 | RSS: Main: 291221504 19:11:34 INFO - PROCESS | 1994 | 19:11:36 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:51874/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51874/tests/kraken/driver.html?testName=audio-oscillator) 19:11:36 INFO - PROCESS | 1994 | RSS: Main: 293761024 19:11:36 INFO - PROCESS | 1994 | 19:11:38 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:51874/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51874/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:11:39 INFO - PROCESS | 1994 | RSS: Main: 292196352 19:11:39 INFO - PROCESS | 1994 | 19:11:42 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:51874/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51874/tests/kraken/driver.html?testName=imaging-darkroom) 19:11:42 INFO - PROCESS | 1994 | RSS: Main: 291799040 19:11:42 INFO - PROCESS | 1994 | 19:11:45 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:51874/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51874/tests/kraken/driver.html?testName=imaging-desaturate) 19:11:46 INFO - PROCESS | 1994 | RSS: Main: 293179392 19:11:46 INFO - PROCESS | 1994 | 19:11:48 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:51874/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51874/tests/kraken/driver.html?testName=json-parse-financial) 19:11:49 INFO - PROCESS | 1994 | RSS: Main: 292265984 19:11:49 INFO - PROCESS | 1994 | 19:11:51 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:51874/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51874/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:11:51 INFO - PROCESS | 1994 | RSS: Main: 326500352 19:11:51 INFO - PROCESS | 1994 | 19:11:53 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:51874/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51874/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:11:54 INFO - PROCESS | 1994 | RSS: Main: 325840896 19:11:54 INFO - PROCESS | 1994 | 19:11:56 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:51874/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51874/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:11:56 INFO - PROCESS | 1994 | RSS: Main: 333574144 19:11:56 INFO - PROCESS | 1994 | 19:11:59 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:51874/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51874/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:12:00 INFO - PROCESS | 1994 | RSS: Main: 335130624 19:12:00 INFO - PROCESS | 1994 | 19:12:02 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:51874/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51874/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:12:03 INFO - PROCESS | 1994 | RSS: Main: 334614528 19:12:03 INFO - PROCESS | 1994 | 19:12:04 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:51874/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51874/tests/kraken/driver.html?testName=ai-astar) 19:12:05 INFO - PROCESS | 1994 | RSS: Main: 394518528 19:12:05 INFO - PROCESS | 1994 | 19:12:05 INFO - PROCESS | 1994 | __start_tp_report 19:12:05 INFO - PROCESS | 1994 | _x_x_mozilla_page_load 19:12:05 INFO - PROCESS | 1994 | _x_x_mozilla_page_load_details 19:12:05 INFO - PROCESS | 1994 | |i|pagename|runs| 19:12:05 INFO - PROCESS | 1994 | |0;ai-astar;112;109;110;112;111;109;117;111;112;111 19:12:05 INFO - PROCESS | 1994 | |1;audio-beat-detection;156;122;138;159;102;159;169;151;175;119 19:12:05 INFO - PROCESS | 1994 | |2;audio-dft;185;186;186;187;184;184;187;187;180;184 19:12:05 INFO - PROCESS | 1994 | |3;audio-fft;77;75;86;77;56;57;56;81;79;56 19:12:05 INFO - PROCESS | 1994 | |4;audio-oscillator;93;100;126;79;77;87;113;78;78;118 19:12:05 INFO - PROCESS | 1994 | |5;imaging-gaussian-blur;87;86;89;107;132;84;89;86;88;84 19:12:05 INFO - PROCESS | 1994 | |6;imaging-darkroom;94;95;95;93;95;93;93;94;93;95 19:12:05 INFO - PROCESS | 1994 | |7;imaging-desaturate;87;87;85;87;88;105;140;105;88;87 19:12:05 INFO - PROCESS | 1994 | |8;json-parse-financial;58;55;54;54;56;54;54;65;56;53 19:12:05 INFO - PROCESS | 1994 | |9;json-stringify-tinderbox;64;62;74;69;76;73;71;66;67;67 19:12:05 INFO - PROCESS | 1994 | |10;stanford-crypto-aes;82;82;82;82;82;83;81;80;81;80 19:12:05 INFO - PROCESS | 1994 | |11;stanford-crypto-ccm;126;120;131;130;128;117;120;118;125;128 19:12:05 INFO - PROCESS | 1994 | |12;stanford-crypto-pbkdf2;142;138;138;139;131;125;138;136;135;138 19:12:05 INFO - PROCESS | 1994 | |13;stanford-crypto-sha256-iterative;66;67;65;67;65;67;89;94;93;68 19:12:05 INFO - PROCESS | 1994 | __end_tp_report 19:12:05 INFO - PROCESS | 1994 | __start_cc_report 19:12:05 INFO - PROCESS | 1994 | _x_x_mozilla_cycle_collect,1219 19:12:05 INFO - PROCESS | 1994 | __end_cc_report 19:12:05 INFO - PROCESS | 1994 | __startTimestamp1458612725101__endTimestamp 19:12:05 INFO - PROCESS | 1994 | 19:12:05 INFO - PROCESS | 1994 | ------- Summary: start ------- 19:12:05 INFO - PROCESS | 1994 | Number of tests: 14 19:12:05 INFO - PROCESS | 1994 | 19:12:05 INFO - PROCESS | 1994 | [#0] ai-astar Cycles:10 Average:111.40 Median:111.50 stddev:2.27 (2.0%) stddev-sans-first:2.40 19:12:05 INFO - PROCESS | 1994 | Values: 112.0 109.0 110.0 112.0 111.0 109.0 117.0 111.0 112.0 111.0 19:12:05 INFO - PROCESS | 1994 | 19:12:05 INFO - PROCESS | 1994 | [#1] audio-beat-detection Cycles:10 Average:145.00 Median:157.50 stddev:23.87 (15.2%) stddev-sans-first:24.98 19:12:05 INFO - PROCESS | 1994 | Values: 156.0 122.0 138.0 159.0 102.0 159.0 169.0 151.0 175.0 119.0 19:12:05 INFO - PROCESS | 1994 | 19:12:05 INFO - PROCESS | 1994 | [#2] audio-dft Cycles:10 Average:185.00 Median:186.00 stddev:2.16 (1.2%) stddev-sans-first:2.29 19:12:05 INFO - PROCESS | 1994 | Values: 185.0 186.0 186.0 187.0 184.0 184.0 187.0 187.0 180.0 184.0 19:12:05 INFO - PROCESS | 1994 | 19:12:05 INFO - PROCESS | 1994 | [#3] audio-fft Cycles:10 Average:70.00 Median:77.00 stddev:12.19 (15.8%) stddev-sans-first:12.67 19:12:05 INFO - PROCESS | 1994 | Values: 77.0 75.0 86.0 77.0 56.0 57.0 56.0 81.0 79.0 56.0 19:12:05 INFO - PROCESS | 1994 | 19:12:05 INFO - PROCESS | 1994 | [#4] audio-oscillator Cycles:10 Average:94.90 Median:78.00 stddev:18.45 (23.7%) stddev-sans-first:19.56 19:12:05 INFO - PROCESS | 1994 | Values: 93.0 100.0 126.0 79.0 77.0 87.0 113.0 78.0 78.0 118.0 19:12:05 INFO - PROCESS | 1994 | 19:12:05 INFO - PROCESS | 1994 | [#5] imaging-gaussian-blur Cycles:10 Average:93.20 Median:86.50 stddev:15.16 (17.5%) stddev-sans-first:15.92 19:12:05 INFO - PROCESS | 1994 | Values: 87.0 86.0 89.0 107.0 132.0 84.0 89.0 86.0 88.0 84.0 19:12:05 INFO - PROCESS | 1994 | 19:12:05 INFO - PROCESS | 1994 | [#6] imaging-darkroom Cycles:10 Average:94.00 Median:94.50 stddev:0.94 (1.0%) stddev-sans-first:1.00 19:12:05 INFO - PROCESS | 1994 | Values: 94.0 95.0 95.0 93.0 95.0 93.0 93.0 94.0 93.0 95.0 19:12:05 INFO - PROCESS | 1994 | 19:12:05 INFO - PROCESS | 1994 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:87.00 stddev:17.23 (19.8%) stddev-sans-first:17.97 19:12:05 INFO - PROCESS | 1994 | Values: 87.0 87.0 85.0 87.0 88.0 105.0 140.0 105.0 88.0 87.0 19:12:05 INFO - PROCESS | 1994 | 19:12:05 INFO - PROCESS | 1994 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:55.50 stddev:3.51 (6.3%) stddev-sans-first:3.64 19:12:05 INFO - PROCESS | 1994 | Values: 58.0 55.0 54.0 54.0 56.0 54.0 54.0 65.0 56.0 53.0 19:12:05 INFO - PROCESS | 1994 | 19:12:05 INFO - PROCESS | 1994 | [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:70.00 stddev:4.53 (6.5%) stddev-sans-first:4.45 19:12:05 INFO - PROCESS | 1994 | Values: 64.0 62.0 74.0 69.0 76.0 73.0 71.0 66.0 67.0 67.0 19:12:05 INFO - PROCESS | 1994 | 19:12:05 INFO - PROCESS | 1994 | [#10] stanford-crypto-aes Cycles:10 Average:81.50 Median:82.00 stddev:0.97 (1.2%) stddev-sans-first:1.01 19:12:05 INFO - PROCESS | 1994 | Values: 82.0 82.0 82.0 82.0 82.0 83.0 81.0 80.0 81.0 80.0 19:12:05 INFO - PROCESS | 1994 | 19:12:05 INFO - PROCESS | 1994 | [#11] stanford-crypto-ccm Cycles:10 Average:124.30 Median:127.00 stddev:5.14 (4.0%) stddev-sans-first:5.42 19:12:05 INFO - PROCESS | 1994 | Values: 126.0 120.0 131.0 130.0 128.0 117.0 120.0 118.0 125.0 128.0 19:12:05 INFO - PROCESS | 1994 | 19:12:05 INFO - PROCESS | 1994 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.00 Median:138.00 stddev:4.81 (3.5%) stddev-sans-first:4.58 19:12:05 INFO - PROCESS | 1994 | Values: 142.0 138.0 138.0 139.0 131.0 125.0 138.0 136.0 135.0 138.0 19:12:05 INFO - PROCESS | 1994 | 19:12:05 INFO - PROCESS | 1994 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.10 Median:67.50 stddev:12.45 (18.4%) stddev-sans-first:12.85 19:12:05 INFO - PROCESS | 1994 | Values: 66.0 67.0 65.0 67.0 65.0 67.0 89.0 94.0 93.0 68.0 19:12:05 INFO - PROCESS | 1994 | -------- Summary: end -------- 19:12:05 INFO - PROCESS | 1994 | 19:12:05 INFO - TEST-INFO | 1994: exit 0 19:12:05 INFO - TEST-OK | kraken | took 57186ms 19:12:05 INFO - SUITE-END | took 1171s 19:12:06 INFO - Completed test suite (00:19:31) 19:12:06 INFO - javascript benchmark 19:12:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2916.679165291818, 3452.2750222453283, 3481.495183198438, 3484.442489201727, 3541.8583256669735, 5565.165225216219, 5612.719364031792, 5613.522850557702, 5640.182173584828, 5648.152777083439, 5616.101423772197, 5695.515881150107, 5707.457791509811, 5795.565332600061, 5803.1875537424685, 5075.441701412841, 5110.872228194297, 5122.923156152642, 5135.6918584885025, 5242.0, 5272.077386457355, 5278.234655974881, 5278.445763194867, 5325.227841962913, 5328.893422131555, 5108.514691104339, 5110.514501122388, 5176.637635365526, 5199.1161502544655, 5222.556082732972, 5169.0954083035695, 5174.818881339173, 5183.481651834824, 5186.962607478482, 5225.712585807779, 5103.923441148386, 5113.2330150477355, 5116.641835071509, 5150.356205474316, 5159.22611608258, 5484.040292948718, 5568.136938774496, 5620.606557540974, 5621.550275977912, 5629.690367029812, 6059.7635868081115, 6062.964237789503, 6091.355349036975, 6095.251420376481, 6108.0, 6273.592216505913, 6288.402601752826, 6321.557490975633, 6328.588641738318, 6333.936660633381, 5705.0, 5777.711114444303, 5782.595218334718, 5782.884342313172, 5806.216160818235, 6188.907166392508, 6212.689365531705, 6229.4393504584805, 6261.686915654199, 6281.246250449975, 5892.499137573354, 5895.35151133375, 5920.993431116721, 5922.318933322636, 5959.255093113361, 5965.28416590012, 6039.909401358896, 6060.969695151496, 6077.088436734525, 6101.664408457489, 6061.636301821904, 6106.005662907935, 6128.938710612926, 6158.0, 6190.845228869224, 6197.1324014637985, 6207.596506227081, 6211.472024877846, 6215.471684906834, 6221.5333849961435, 4890.462049174659, 4890.755462226874, 4892.535209155125, 4909.926351104737, 4960.90078198434, 4298.075913678574, 4354.433923589913, 4421.336799480104, 4452.532484089189, 4498.167838949805, 5677.574181936371, 5687.488126068591, 5691.4877661010705, 5697.572682048863, 5715.657060576379, 5926.851828704231, 6221.720022598994, 6305.936940630535, 6332.715027823759, 6335.986242201226, 5547.2511210986, 5599.776008959678, 5607.074832652566, 5697.658140511582, 5725.885482290331, 5318.0, 5333.2266821310695, 5338.91991620126, 5340.172273297645, 5341.439148889311, 6280.811575652738, 6291.02489114188, 6304.306526282014, 6309.526785491106, 6319.684015799284, 5303.973480132575, 6139.969300153471, 6176.9073463897175, 6222.471089957223, 6331.5251356147555, 6251.124842521959, 6302.590331628429, 6311.0, 6319.304876463493, 6334.334894835976, 5567.498925096761, 5986.862496125722, 6129.1112788644505, 6154.476869465966, 6156.26124865019, 5305.734713264244, 6108.786192483241, 6178.567500275118, 6179.752809887555, 6271.62370257786, 5894.351621321737, 6060.636361818305, 6067.180930574316, 6074.210352654127, 6077.6353418795015, 6034.456898879122, 6036.8188954331445, 6040.305364883095, 6045.939540604713, 6063.999440092335, 5764.827055188351, 5828.504577110993, 5866.6480011199465, 5883.676397798162, 5885.529157667462, 5377.166539186433, 5932.288125424977, 5973.731182096903, 5980.72083005873, 6082.391760824059, 5921.555883308855, 5925.259342582177, 5942.494887934574, 5951.851203719942, 5958.374370691015], "unit": "score", "name": "dojo.html", "value": 5643.042996697655}, {"lowerIsBetter": false, "replicates": [463.2379735335371, 523.8762853678861, 535.7819349484962, 601.712335601812, 624.051441808451, 29053.41893162138, 39994.40008399873, 40284.19431611366, 40371.798141009254, 40415.79792101035, 41809.0, 42700.57299427005, 42736.35895461571, 42780.0, 42784.14431711364, 8953.77615559613, 9596.040395960383, 9610.567524461416, 9615.230781537495, 9620.518974051305, 9575.138237558618, 9712.0, 9723.513824308757, 9728.805423891517, 9747.707568772948, 9621.374610650286, 9652.0, 9658.806823863519, 9677.419354838697, 9769.0, 9626.951865240699, 9743.12311891926, 9746.512674366253, 9748.658796942109, 9755.12203901645, 9694.51527423633, 9809.558569864374, 9833.26250531213, 9833.26250531213, 9841.212702983745, 36588.63411365879, 41112.0, 41574.58425415737, 41731.0, 41765.79117104426, 3297.38998285318, 3448.758586898918, 3495.528103706018, 3616.5117709109195, 3868.439076333944, 29318.0, 30522.84738576315, 30568.388632227452, 30680.846595767103, 30715.692843071505, 2797.860106994642, 2816.9295767605768, 2844.630198074258, 2880.74073333401, 2888.494513460136, 507114.0, 508849.0, 514827.2586370704, 515694.0, 516005.0, 45960.5403945963, 46448.5355146451, 70491.64754176197, 71240.0, 71832.0, 45967.0, 46038.0, 46089.5391046092, 46098.078038439045, 46200.07599847984, 15643.139627320379, 15781.28984195714, 15800.36798528046, 15804.68390632204, 15829.920850395674, 12678.556250531186, 12789.936050319875, 12791.168574042658, 12802.03984701151, 12803.103782735305, 14710.705785884222, 14946.925265373604, 14981.775273370908, 14992.400303987719, 15065.774013389808, 6429.710663020175, 6501.0, 6541.247756508063, 6573.868522629617, 6577.572457790228, 1016.6492560066913, 1025.876894772632, 1049.1134990932649, 1054.5728979763207, 1088.9292196007234, 29215.561766573093, 29279.707202927697, 29721.0, 30021.249468763457, 30040.098797036124, 1106.5684383090602, 1109.7780443911088, 1119.1158984402232, 1209.7096696792707, 1238.13949305232, 14918.328675209425, 15152.924235378972, 15499.9150059497, 16381.426650067191, 16580.17099145038, 669241.0, 669792.0, 670192.0, 672040.0, 677897.0, 63484.0, 63825.04262436067, 63980.68009659922, 64026.0, 64067.679661601396, 1363.6863521390135, 1464.3044553836842, 1495.4915328788263, 1500.1749038028822, 1510.3807438949977, 29284.414311714074, 29320.560191596716, 29930.401391972475, 30082.24794380158, 30617.693823061483, 51457.742711287705, 51877.74061129821, 52172.73913630407, 52234.95530089453, 52409.0, 407035.0, 408376.0, 409460.0, 410658.0, 411152.0, 33677.98966031023, 33720.49419258762, 34427.483587746705, 34452.48321275233, 34568.82715586406, 46146.53853461557, 46285.0, 46410.0, 46853.0, 47794.52205477901, 37295.06762330963, 37448.438273425374, 38111.237775244896, 38223.80888095542, 39338.80330598329, 31113.688863111078, 33276.83361583177, 36438.63561364458, 36929.44605830861, 36940.81529592335, 30792.761399410443, 36791.26417471582, 37940.241195176495, 38043.42934856035, 38403.61596384112, 32231.35537289288, 33447.738838024095, 33640.1589960253, 33728.325433491686, 33796.3240735179, 24342.878285608458, 24343.634845477685, 24413.755862441147, 24979.750202498468, 25154.496910062062], "unit": "score", "name": "ext.html", "value": 19678.059155030576}, {"lowerIsBetter": false, "replicates": [358.75604588879565, 360.97834129952207, 368.09999551097576, 368.2377478619258, 369.15831903260556, 19437.805621943775, 20205.191792328307, 20496.0, 20963.580728385423, 21005.894970525125, 11854.7629047419, 12215.694607634792, 12220.816687749668, 12231.816522752166, 12241.898229159375, 4376.89057773555, 4885.487023862496, 5438.428964958682, 5443.591730620219, 5471.206675032118, 5377.677339359651, 5408.296921400232, 5436.157395603688, 5439.945600544003, 5453.2092846537225, 5214.06146893559, 5429.592780541456, 5446.91829622556, 5490.396056433789, 5492.395836457987, 4640.628749700016, 5412.972935135299, 5459.863503412406, 5461.42655021221, 5482.862928426801, 5180.456052114511, 5212.009718153577, 5269.077911365495, 5269.604779641504, 5278.076336641073, 13230.66923326915, 13551.39018744159, 13664.863351366459, 13676.452941882313, 13707.0, 2047.846411519127, 2353.752855950118, 2402.783749462557, 2431.6474111253947, 2829.858507074638, 9850.852237216448, 9988.0, 9993.550290236957, 10269.640562580274, 10281.177505799518, 1764.9911750441295, 1818.4635532517939, 1843.3456123076382, 1864.5245462407, 1903.9714404283948, 102303.48848255785, 107595.99999999921, 107808.0, 108211.0, 108660.0, 11349.60276390339, 11434.428278586038, 11468.197226194254, 11534.307941523535, 11626.593069242535, 13838.723225535634, 13908.791368129487, 13941.233232172328, 13951.0, 13963.301834908214, 8423.189014361818, 8577.95711021441, 8596.441231319945, 8690.391672582859, 8695.0, 8693.869591956125, 8710.433821801562, 8745.12548745133, 8822.735317940473, 8852.424592401601, 4425.22558552252, 4507.6619253555455, 4512.165249428801, 4564.52072532386, 4566.429196350457, 1687.8059023212488, 1778.2264714849082, 1849.8705090643796, 1909.625069949634, 1959.177145598852, 857.9699710510228, 947.0955237747934, 962.2782912815388, 963.5086106085946, 975.2977855943709, 16145.0, 19013.59898482234, 20184.69722954157, 20281.985900704905, 20410.08154633045, 889.2485849457198, 935.4527601353285, 942.830290547708, 967.2938754708961, 977.2816979520047, 9282.90717092834, 10633.415162166155, 10807.78384432307, 10838.566457341776, 10842.620508282173, 594726.0, 603866.0, 619337.0, 644098.0, 645152.0, 86640.56679716561, 98129.50935245278, 102247.0, 107008.9299106999, 109373.0, 960.490939801906, 973.2749101919115, 984.9064338887795, 986.2701600815345, 1008.9041541053441, 13590.388432520758, 15876.603084922508, 17830.10849457496, 18304.0, 18583.07084645735, 48677.26984095312, 50885.74557127191, 50992.0, 51603.0, 51885.48114518957, 63774.3622563787, 66587.66706166438, 67066.6646666783, 67828.66085669737, 68649.0, 6438.67806609677, 7548.282913123464, 7676.884846727192, 7703.422243331885, 7788.299053085249, 7200.387967022862, 10579.682609521727, 12346.938265308616, 12646.620601381974, 12828.807567886675, 10098.29311948186, 10571.735706607396, 10776.784464310827, 10876.18428617841, 11081.390523521284, 9403.952980235055, 10620.15038796879, 10624.734381640521, 10663.0, 11001.559937602406, 8804.64781408762, 10939.124870010539, 11176.88823111791, 11206.271592346471, 11260.761316255042, 7663.0, 7738.226177382442, 7766.650500727594, 7832.099308579358, 8031.357491400557, 10327.32872363294, 10738.355698658106, 10794.73013174677, 11065.280756750786, 11072.280301780358], "unit": "score", "name": "jquery.html", "value": 8860.763393362262}, {"lowerIsBetter": false, "replicates": [1430.7210094031655, 1610.685916246332, 1641.4829328761439, 1760.9911950440246, 2052.8563000589957, 8012.8798068028955, 8618.827623447534, 8724.17120373565, 8761.167689069529, 8774.780630484242, 8494.277986371166, 8663.436876603033, 8684.956575217115, 8685.782855428617, 8686.174813392718, 2207.922722704706, 2445.7921076708412, 2482.0444129010325, 2508.6613307203565, 2516.748325167487, 2535.8985640574356, 2541.072508534381, 2542.618607208924, 2546.7835234005133, 2550.33691240277, 2418.770216829407, 2504.3613878460965, 2504.6994360676745, 2507.9749202508015, 2517.8363406378617, 2436.183878400729, 2497.163450244161, 2514.6856642919633, 2518.8236823422367, 2518.9748102518924, 2482.6027835546224, 2507.774300312962, 2518.942044341381, 2519.659845920814, 2530.9240722778345, 8805.42764720291, 8877.467351958838, 8881.555922203865, 8882.11178882113, 8897.288216942694, 5497.120460726304, 5638.689872057035, 5641.802536911188, 5644.153376993443, 5647.068233741427, 3625.800580968046, 3714.9814250928844, 3769.1707824278888, 3773.339665558516, 3798.1833905710405, 1043.5095505112586, 1065.5631191211644, 1071.8981696738874, 1083.7019819549607, 1085.0722632149557, 11820.763584728344, 11843.348615826126, 11849.94075029628, 11852.933236008801, 11887.643370698806, 4943.604511639061, 4953.851384458472, 5056.342675452242, 5056.84829455117, 5074.11203039474, 8714.738557843275, 10149.543270552844, 10169.440680762482, 10177.338472999232, 10191.337563058378, 5603.6077474577205, 5605.775768969277, 5610.579206559524, 5617.915731264035, 5642.520385767174, 4487.708298960557, 4650.069986002813, 4921.483244259372, 4980.90038199234, 5026.070177017264, 3900.902477438087, 4008.6793056555407, 4026.8187931543152, 4039.0508230565792, 4074.4295798588223, 1323.808047833078, 1339.9531016414378, 1346.1048402812216, 1349.3590544491287, 1353.5195005773005, 1345.3744009035845, 1377.9586612401645, 1400.1459109942928, 1413.0673755321438, 1422.0188070231507, 8080.43436959419, 8218.342532597379, 8283.58582070894, 8311.25198732117, 8432.241098301183, 1140.2531341971023, 1177.4289469607234, 1237.3380241570717, 1241.2862604002735, 1249.950001999928, 6334.588251763621, 6340.873182536416, 6422.8715425691225, 6431.614103153825, 6436.485081193493, 10267.589296428208, 10625.893741062646, 10705.1435885129, 10776.892231077745, 10785.676429707122, 10532.789344213073, 10544.420056896792, 10651.98806113418, 10752.193585480964, 10757.677269681923, 8167.346612271004, 8326.50040997542, 8354.164583541718, 8413.579321033923, 8416.326693864476, 7751.341136003277, 7888.0, 7911.248431399008, 7940.761777146695, 7961.0, 9388.061193880558, 9486.051394860458, 9629.951850240705, 9752.317337786571, 9756.707298781048, 9716.854247186156, 9751.951240244038, 9883.950580247052, 10043.949780251345, 10078.395296282246, 6886.793396198122, 7085.539439936388, 7438.367738742268, 7542.585157816373, 7690.230976902265, 8246.257836794717, 8308.626111824862, 8310.501369917823, 8323.542205178774, 8346.749597512084, 7296.854062918818, 7386.96306518464, 7404.444666650131, 7445.255474452511, 7566.962165189138, 7206.639668016683, 7278.96360518194, 7291.4166866649475, 7314.743983960536, 7342.339189472973, 7678.232176782277, 7745.612719364122, 7751.689932402866, 7835.960820196091, 7891.526508409514, 6050.183225264709, 6987.720491180499, 6988.895166572607, 6990.825229369103, 7078.0, 6079.726412311545, 7221.494495385273, 7222.927770722225, 7223.422126229784, 7224.89162662571], "unit": "score", "name": "mootools.html", "value": 5012.860847667707}, {"lowerIsBetter": false, "replicates": [321.16336942265394, 324.89928122282095, 328.9391462579421, 332.44315771083427, 333.75802543156215, 6573.309802470743, 6592.637404942726, 6629.204495460552, 6653.4011938925605, 6664.500162487809, 5478.753456094475, 6419.812334718081, 6559.147310849595, 6587.077809106729, 6601.768938087168, 4661.067786442708, 4783.210770222909, 4820.71075735457, 4909.962365618264, 4914.877128071791, 4879.634027447938, 4917.262410638397, 4920.0159968006365, 4920.852374428773, 4926.753662316888, 4847.369841920546, 4858.41698996121, 4861.781219845116, 4865.781039853215, 4866.756662166895, 4657.301404789275, 4736.881577960578, 4744.0, 4767.118083154627, 4784.90430191396, 4155.688323375759, 4169.332906734938, 4176.14389050244, 4179.164167166578, 4182.079942412664, 6264.686765661699, 6304.338044505307, 6360.9045864312075, 6381.521385896076, 6389.233292004989, 5765.1928729977835, 5767.163761254595, 5771.88456230873, 5776.624519406225, 5776.740046697909, 6756.290589488131, 7019.8596028079155, 7038.225795162528, 7042.225355210922, 7049.92950070503, 4721.504242054569, 4722.693024953367, 4732.692374995614, 4742.336072949755, 4749.762511874393, 7251.383632391253, 7383.8154046149275, 7436.628168591549, 7442.776716698508, 7470.551766893949, 3996.8800935971967, 4813.278008298783, 4814.229723244334, 4818.012307476959, 4819.060283244734, 4050.675945924319, 4855.271709243641, 4877.268409738567, 4892.877678058077, 4908.092002979461, 4931.3835770528685, 5608.46719561641, 5773.8556536086935, 5781.624194427349, 5787.1319302104175, 6733.192016957996, 7034.6834392452465, 7058.505904586732, 7065.0, 7082.291770822876, 1668.8748343874258, 1701.9149042547824, 1711.0332662045905, 1711.1957380031365, 1714.2971381733678, 1095.9287646302964, 1107.3466654673782, 1115.1636272795404, 1128.6501184632625, 1132.456420917964, 5317.308749862493, 6335.11308416822, 6441.613503189824, 6585.637789921505, 6603.339666033358, 7339.449541284425, 7339.449541284425, 7342.889856652155, 7355.448341374311, 7365.2634736525915, 6603.537752357289, 6608.4052435281055, 6609.438197753148, 6609.801705948829, 6614.470842332602, 3822.636849499293, 3869.587600525788, 3874.5737968823405, 3881.573026967031, 3881.6506514413836, 7368.078990126234, 7630.313271805564, 7698.807529811799, 7705.9229407706325, 7707.0, 7504.549727016397, 7543.358814500719, 7560.697572097164, 7568.470207085451, 7569.3566046886635, 7626.58053807046, 7635.847283054419, 7645.617719114133, 7673.117591477052, 7675.232476752391, 7269.890951635835, 7297.416206703557, 7312.780616581511, 7318.194998550049, 7327.487075904849, 6595.472362211108, 6616.610511792577, 6857.897131542931, 7214.819629509304, 7228.421726261991, 7141.285871412817, 7659.195784442776, 7670.348020418104, 7674.462787604814, 7674.769756907302, 4813.109574728686, 4820.469748327611, 4820.68665536739, 4826.0830442215865, 4828.589569886599, 7257.600831954293, 7277.235890231449, 7285.380742636935, 7289.0, 7299.160596531255, 6839.62382068991, 6952.0, 7080.716771329089, 7106.538075025107, 7123.608201548965, 7020.403265722471, 7048.295170482911, 7049.682764275723, 7069.858602828018, 7078.398336141279, 5402.378726446509, 6916.654167291716, 6918.238993710788, 6925.411340036153, 6925.515213934977, 6789.660516974032, 7031.1211098612675, 7046.753363632453, 7048.224695283618, 7059.047028651066, 6655.367740064686, 6789.966050169717, 6892.276310987274, 6913.170419549686, 6943.618101004493], "unit": "score", "name": "prototype.html", "value": 5173.081831983765}, {"lowerIsBetter": false, "replicates": [692.5498426023086, 746.3357611725562, 748.3900620993886, 758.2758465665287, 762.7826069570174, 15301.540953771391, 15502.61243468914, 15525.456609018687, 15532.611684707874, 15565.53303400897, 12526.686832829184, 12538.56115035974, 12544.37278136094, 12591.811122833165, 14083.788743168861, 771.8842173673937, 779.8752199648058, 922.1239822168933, 924.7225832250315, 938.3994243684048, 941.9058094190594, 942.7313215733517, 945.6170251048336, 945.9006804285519, 952.0907533305711, 985.3693636072883, 987.9802403951917, 988.85661579071, 989.8762654668167, 990.5889056041734, 801.7755028592004, 978.6427953796884, 990.2721499697716, 993.9155171810332, 998.825205589019, 736.6390468670367, 737.2995654128599, 737.7971057959104, 737.8634952533798, 739.1425945902781, 15079.54761357161, 15109.773353399598, 15126.621834454227, 15205.163715995615, 15221.695566088727, 10851.67444976644, 12503.124781265315, 12594.496220151183, 12661.93669031649, 12975.286359250238, 9887.90112098877, 10139.797204055878, 10249.74375640615, 10397.376157430503, 10633.46832658364, 3439.8968030959113, 3483.372992861284, 3577.266660334625, 3598.280343931198, 3669.119411341259, 74872.625636872, 74913.62543187359, 74958.0, 75277.87083193756, 75285.0, 9438.52807359643, 9459.810803784023, 9473.810523789623, 9512.762180945532, 9756.707298781048, 21306.78693213079, 21392.57214855694, 21416.036278367512, 21424.892875535523, 22346.66480002801, 7668.769936901902, 7676.270754278335, 7835.608219588998, 7856.0, 7965.163657815961, 4149.91700166001, 4205.474315710536, 4206.242876282298, 4216.9789151054665, 4274.038341373166, 3662.5421822272215, 3700.40793473043, 3710.8330125144435, 3716.089558058293, 3717.9070523236596, 583.588570058108, 664.4020381656547, 675.0380707491804, 694.3160986428364, 701.1656129206228, 493.97283149427125, 502.9949700502948, 585.3765739487433, 623.2085251730367, 631.1227393922452, 7737.535747855034, 8157.265846073882, 8239.299659528888, 8279.917200828035, 8318.66725330992, 495.23486213799765, 497.2566013809306, 593.7773334999375, 603.8973374526253, 609.6403122157948, 3831.63599458051, 3846.74996125251, 3860.9613903861164, 3973.264945985002, 4065.3698676705158, 83023.0, 85989.0, 86015.70976435358, 86233.56883215543, 86345.5682721595, 72349.63825180946, 77893.61053194811, 78324.03463515113, 78457.0, 78574.607126964, 65798.34201658018, 69601.65199174175, 69606.0, 70748.2925170752, 70808.29191708018, 7725.613719314124, 7821.528830149441, 7868.960655196687, 7962.522248665098, 7982.6008699565955, 39301.0, 40033.79983100066, 49422.0, 49727.75136124296, 50204.74897625635, 50713.23930140977, 54954.17568736552, 69112.0, 69794.30205697878, 71534.28465715276, 9187.908120918706, 9345.953270233606, 9977.052180042885, 10084.243681724047, 10253.692389228336, 9848.015198480094, 10654.836761167327, 10840.078593319657, 10902.56389744433, 11298.717532061435, 10180.694579162637, 10288.434136122585, 10546.947265263625, 10630.043296103388, 10709.785804284027, 10091.293609447268, 10362.689119326433, 10365.481725913825, 10573.418461984666, 11184.608538701106, 9996.0, 10056.849147262943, 10153.340032897839, 10166.847497287694, 10174.593016279561, 7772.872933424735, 8584.871226931726, 8881.111888811067, 9059.0, 9228.35401521887, 7951.522908625501, 8115.4319197655595, 8635.6977505787, 8834.38148872931, 8870.2460290876], "unit": "score", "name": "yui.html", "value": 6732.645085869338}], "name": "dromaeo_css", "value": 7455.9591584015725}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 109.0, 110.0, 112.0, 111.0, 109.0, 117.0, 111.0, 112.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.4}, {"lowerIsBetter": true, "replicates": [156.0, 122.0, 138.0, 159.0, 102.0, 159.0, 169.0, 151.0, 175.0, 119.0], "unit": "score", "name": "audio-beat-detection", "value": 145.0}, {"lowerIsBetter": true, "replicates": [185.0, 186.0, 186.0, 187.0, 184.0, 184.0, 187.0, 187.0, 180.0, 184.0], "unit": "score", "name": "audio-dft", "value": 185.0}, {"lowerIsBetter": true, "replicates": [77.0, 75.0, 86.0, 77.0, 56.0, 57.0, 56.0, 81.0, 79.0, 56.0], "unit": "score", "name": "audio-fft", "value": 70.0}, {"lowerIsBetter": true, "replicates": [93.0, 100.0, 126.0, 79.0, 77.0, 87.0, 113.0, 78.0, 78.0, 118.0], "unit": "score", "name": "audio-oscillator", "value": 94.9}, {"lowerIsBetter": true, "replicates": [87.0, 86.0, 89.0, 107.0, 132.0, 84.0, 89.0, 86.0, 88.0, 84.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 93.2}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 95.0, 93.0, 95.0, 93.0, 93.0, 94.0, 93.0, 95.0], "unit": "score", "name": "imaging-darkroom", "value": 94.0}, {"lowerIsBetter": true, "replicates": [87.0, 87.0, 85.0, 87.0, 88.0, 105.0, 140.0, 105.0, 88.0, 87.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [58.0, 55.0, 54.0, 54.0, 56.0, 54.0, 54.0, 65.0, 56.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.9}, {"lowerIsBetter": true, "replicates": [64.0, 62.0, 74.0, 69.0, 76.0, 73.0, 71.0, 66.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.9}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 82.0, 82.0, 82.0, 83.0, 81.0, 80.0, 81.0, 80.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.5}, {"lowerIsBetter": true, "replicates": [126.0, 120.0, 131.0, 130.0, 128.0, 117.0, 120.0, 118.0, 125.0, 128.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.3}, {"lowerIsBetter": true, "replicates": [142.0, 138.0, 138.0, 139.0, 131.0, 125.0, 138.0, 136.0, 135.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.0}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 65.0, 67.0, 65.0, 67.0, 89.0, 94.0, 93.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 74.1}], "name": "kraken", "value": 1430.0999999999997}]} 19:12:06 INFO - Return code: 0 19:12:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:12:06 ERROR - # TBPL SUCCESS # 19:12:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:12:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:12:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:12:06 INFO - 2016-03-21 19:12:06.430 screenresolution[1998:28773] starting screenresolution argv=screenresolution get 19:12:06 INFO - 2016-03-21 19:12:06.433 screenresolution[1998:28773] Display 0: 1600x1200x32@60 19:12:06 INFO - 2016-03-21 19:12:06.439 screenresolution[1999:28776] starting screenresolution argv=screenresolution list 19:12:06 INFO - Available Modes on Display 0 19:12:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:12:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:12:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:12:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:12:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:12:06 INFO - Intel Iris: 19:12:06 INFO - Chipset Model: Intel Iris 19:12:06 INFO - Type: GPU 19:12:06 INFO - Bus: Built-In 19:12:06 INFO - VRAM (Dynamic, Max): 1536 MB 19:12:06 INFO - Vendor: Intel (0x8086) 19:12:06 INFO - Device ID: 0x0a2e 19:12:06 INFO - Revision ID: 0x0009 19:12:06 INFO - Displays: 19:12:06 INFO - Display: 19:12:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:12:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:12:06 INFO - Display Serial Number: 1600x1200 60 19:12:06 INFO - Main Display: Yes 19:12:06 INFO - Mirror: Off 19:12:06 INFO - Online: Yes 19:12:06 INFO - Rotation: Supported 19:12:06 INFO - Return code: 0 19:12:06 INFO - Running post-action listener: _resource_record_post_action 19:12:06 INFO - Running post-run listener: _resource_record_post_run 19:12:07 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 3346432; Write bytes: 704467456; Read time: 41; Write time: 2168 19:12:07 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 389403136; Write bytes: 384396800; Read time: 29874; Write time: 701 19:12:07 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 3346432; Write bytes: 298587136; Read time: 41; Write time: 1417 19:12:07 INFO - Running post-run listener: _upload_blobber_files 19:12:07 INFO - Blob upload gear active. 19:12:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:12:07 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 19:12:07 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'] 19:12:07 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 19:12:08 INFO - (blobuploader) - INFO - Open directory for files ... 19:12:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:12:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:12:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:12:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:12:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:12:09 INFO - (blobuploader) - INFO - Done attempting. 19:12:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:12:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:12:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:12:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:12:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:12:10 INFO - (blobuploader) - INFO - Done attempting. 19:12:10 INFO - (blobuploader) - INFO - Iteration through files over. 19:12:10 INFO - Return code: 0 19:12:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:12:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:12:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5c6fcc2cca4272407d32df40d2125dd586b371e5e277c20770aaf42f36f9c97e930934bf685d9b80dd9bd85b58d94e414e1b811cf18ce2c6429c5ba725d924e9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa01b02f2d8e651131d17e2f5607b22fb0febedd37a5c1cd434308306c9dbf746ca211c2613717fd86e0489eb6d77967ee24d5f5e11eefbba2ff2baece169af8"} 19:12:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:12:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:12:10 INFO - Contents: 19:12:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5c6fcc2cca4272407d32df40d2125dd586b371e5e277c20770aaf42f36f9c97e930934bf685d9b80dd9bd85b58d94e414e1b811cf18ce2c6429c5ba725d924e9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa01b02f2d8e651131d17e2f5607b22fb0febedd37a5c1cd434308306c9dbf746ca211c2613717fd86e0489eb6d77967ee24d5f5e11eefbba2ff2baece169af8"} 19:12:10 INFO - Running post-run listener: copy_logs_to_upload_dir 19:12:10 INFO - Copying logs to upload dir... 19:12:10 INFO - mkdir: /builds/slave/test/build/upload/logs 19:12:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.605061 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-03-21 19:12:10.585648) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-21 19:12:10.589241) ========= 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.OCiyY8XG80/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.1FWPqtKwSM/Listeners TMPDIR=/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5c6fcc2cca4272407d32df40d2125dd586b371e5e277c20770aaf42f36f9c97e930934bf685d9b80dd9bd85b58d94e414e1b811cf18ce2c6429c5ba725d924e9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa01b02f2d8e651131d17e2f5607b22fb0febedd37a5c1cd434308306c9dbf746ca211c2613717fd86e0489eb6d77967ee24d5f5e11eefbba2ff2baece169af8"} build_url:https://queue.taskcluster.net/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011097 build_url: 'https://queue.taskcluster.net/v1/task/ftoaAn_aQPGaiCb6uOLEIQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5c6fcc2cca4272407d32df40d2125dd586b371e5e277c20770aaf42f36f9c97e930934bf685d9b80dd9bd85b58d94e414e1b811cf18ce2c6429c5ba725d924e9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa01b02f2d8e651131d17e2f5607b22fb0febedd37a5c1cd434308306c9dbf746ca211c2613717fd86e0489eb6d77967ee24d5f5e11eefbba2ff2baece169af8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-21 19:12:10.616535) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 19:12:10.616836) ========= 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.OCiyY8XG80/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.1FWPqtKwSM/Listeners TMPDIR=/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/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.005222 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 19:12:10.665658) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-21 19:12:10.665966) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-21 19:12:10.666306) ========= ========= Total master_lag: 0.26 =========