builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0160 starttime: 1456424484.35 results: success (0) buildid: 20160225084244 builduid: f85e57b0b3d9440e8535c9c69b0141a6 revision: 17ba8c582eba5fb32809f1480867c200f69b5e2f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-25 10:21:24.348071) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-25 10:21:24.348515) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-25 10:21:24.348809) ========= 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.gGerKSmtfc/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.JMAsRxe77i/Listeners TMPDIR=/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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.005884 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-25 10:21:24.372868) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-25 10:21:24.373184) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-25 10:21:24.390378) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 10:21:24.390706) ========= 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.gGerKSmtfc/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.JMAsRxe77i/Listeners TMPDIR=/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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.005962 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 10:21:24.438849) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-25 10:21:24.439250) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-25 10:21:24.439669) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 10:21:24.439965) ========= 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.gGerKSmtfc/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.JMAsRxe77i/Listeners TMPDIR=/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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-02-25 10:21:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 159M=0s 2016-02-25 10:21:24 (159 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.176263 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 10:21:24.631445) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 10:21:24.631763) ========= 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.gGerKSmtfc/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.JMAsRxe77i/Listeners TMPDIR=/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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.026874 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 10:21:24.680604) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-25 10:21:24.680955) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 17ba8c582eba5fb32809f1480867c200f69b5e2f --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 17ba8c582eba5fb32809f1480867c200f69b5e2f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.gGerKSmtfc/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.JMAsRxe77i/Listeners TMPDIR=/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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-02-25 10:21:24,758 truncating revision to first 12 chars 2016-02-25 10:21:24,758 Setting DEBUG logging. 2016-02-25 10:21:24,758 attempt 1/10 2016-02-25 10:21:24,758 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/17ba8c582eba?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-25 10:21:25,723 unpacking tar archive at: fx-team-17ba8c582eba/testing/mozharness/ program finished with exit code 0 elapsedTime=1.211814 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-25 10:21:25.910822) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-25 10:21:25.911206) ========= echo 17ba8c582eba5fb32809f1480867c200f69b5e2f in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'17ba8c582eba5fb32809f1480867c200f69b5e2f'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.gGerKSmtfc/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.JMAsRxe77i/Listeners TMPDIR=/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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 17ba8c582eba5fb32809f1480867c200f69b5e2f program finished with exit code 0 elapsedTime=0.005961 script_repo_revision: '17ba8c582eba5fb32809f1480867c200f69b5e2f' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-25 10:21:25.960769) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-25 10:21:25.961095) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-25 10:21:25.974888) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-02-25 10:21:25.975198) ========= /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.gGerKSmtfc/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.JMAsRxe77i/Listeners TMPDIR=/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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 10:21:26 INFO - MultiFileLogger online at 20160225 10:21:26 in /builds/slave/test 10:21:26 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 10:21:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:21:26 INFO - {'append_to_log': False, 10:21:26 INFO - 'base_work_dir': '/builds/slave/test', 10:21:26 INFO - 'blob_upload_branch': 'Fx-Team', 10:21:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:21:26 INFO - 'branch': 'Fx-Team', 10:21:26 INFO - 'buildbot_json_path': 'buildprops.json', 10:21:26 INFO - 'config_files': ('talos/mac_config.py',), 10:21:26 INFO - 'default_actions': ('clobber', 10:21:26 INFO - 'read-buildbot-config', 10:21:26 INFO - 'download-and-extract', 10:21:26 INFO - 'populate-webroot', 10:21:26 INFO - 'create-virtualenv', 10:21:26 INFO - 'install', 10:21:26 INFO - 'run-tests'), 10:21:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:21:26 INFO - 'download_minidump_stackwalk': True, 10:21:26 INFO - 'download_symbols': 'ondemand', 10:21:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:21:26 INFO - 'tooltool.py': '/tools/tooltool.py', 10:21:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:21:26 INFO - '/tools/misc-python/virtualenv.py')}, 10:21:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:21:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:21:26 INFO - 'installer_path': 'installer.exe', 10:21:26 INFO - 'log_level': 'info', 10:21:26 INFO - 'log_name': 'talos', 10:21:26 INFO - 'log_to_console': True, 10:21:26 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:21:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:21:26 INFO - 'opt_config_files': (), 10:21:26 INFO - 'pip_index': False, 10:21:26 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:21:26 INFO - 'cmd': ('bash', 10:21:26 INFO - '-c', 10:21:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:21:26 INFO - 'enabled': True, 10:21:26 INFO - 'halt_on_failure': False, 10:21:26 INFO - 'name': 'check_screen_resolution'},), 10:21:26 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:21:26 INFO - 'cmd': ('bash', 10:21:26 INFO - '-c', 10:21:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:21:26 INFO - 'enabled': True, 10:21:26 INFO - 'halt_on_failure': False, 10:21:26 INFO - 'name': 'check_screen_resolution'},), 10:21:26 INFO - 'run_cmd_checks_enabled': True, 10:21:26 INFO - 'sps_profile': False, 10:21:26 INFO - 'sps_profile_interval': 0, 10:21:26 INFO - 'suite': 'dromaeojs', 10:21:26 INFO - 'system_bits': '32', 10:21:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:21:26 INFO - 'title': 't-yosemite-r7-0160', 10:21:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:21:26 INFO - 'use_talos_json': True, 10:21:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:21:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:21:26 INFO - 'work_dir': 'build'} 10:21:26 INFO - ##### 10:21:26 INFO - ##### Running clobber step. 10:21:26 INFO - ##### 10:21:26 INFO - Running pre-action listener: _resource_record_pre_action 10:21:26 INFO - Running main action method: clobber 10:21:26 INFO - rmtree: /builds/slave/test/build 10:21:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:21:27 INFO - Running post-action listener: _resource_record_post_action 10:21:27 INFO - ##### 10:21:27 INFO - ##### Running read-buildbot-config step. 10:21:27 INFO - ##### 10:21:27 INFO - Running pre-action listener: _resource_record_pre_action 10:21:27 INFO - Running main action method: read_buildbot_config 10:21:27 INFO - Using buildbot properties: 10:21:27 INFO - { 10:21:27 INFO - "project": "", 10:21:27 INFO - "product": "firefox", 10:21:27 INFO - "script_repo_revision": "production", 10:21:27 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 10:21:27 INFO - "repository": "", 10:21:27 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 10:21:27 INFO - "buildid": "20160225084244", 10:21:27 INFO - "pgo_build": "False", 10:21:27 INFO - "basedir": "/builds/slave/test", 10:21:27 INFO - "buildnumber": 499, 10:21:27 INFO - "slavename": "t-yosemite-r7-0160", 10:21:27 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 10:21:27 INFO - "platform": "yosemite_r7", 10:21:27 INFO - "scheduler": "tests-fx-team-macosx64-talos", 10:21:27 INFO - "branch": "fx-team", 10:21:27 INFO - "repo_path": "integration/fx-team", 10:21:27 INFO - "revision": "17ba8c582eba5fb32809f1480867c200f69b5e2f", 10:21:27 INFO - "stage_platform": "macosx64", 10:21:27 INFO - "builduid": "f85e57b0b3d9440e8535c9c69b0141a6", 10:21:27 INFO - "slavebuilddir": "test" 10:21:27 INFO - } 10:21:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/PwXC--t0Roa5fCt94ik59w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 10:21:27 INFO - Running post-action listener: _resource_record_post_action 10:21:27 INFO - ##### 10:21:27 INFO - ##### Running download-and-extract step. 10:21:27 INFO - ##### 10:21:27 INFO - Running pre-action listener: _resource_record_pre_action 10:21:27 INFO - Running main action method: download_and_extract 10:21:27 INFO - mkdir: /builds/slave/test/build/tests 10:21:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:27 INFO - https://queue.taskcluster.net/v1/task/PwXC--t0Roa5fCt94ik59w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:21:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwXC--t0Roa5fCt94ik59w/artifacts/public/build/test_packages.json 10:21:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwXC--t0Roa5fCt94ik59w/artifacts/public/build/test_packages.json 10:21:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwXC--t0Roa5fCt94ik59w/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 10:21:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwXC--t0Roa5fCt94ik59w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 10:21:29 INFO - Downloaded 1277 bytes. 10:21:29 INFO - Reading from file /builds/slave/test/build/test_packages.json 10:21:29 INFO - Using the following test package requirements: 10:21:29 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 10:21:29 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:21:29 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 10:21:29 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:21:29 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 10:21:29 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:21:29 INFO - u'jsshell-mac.zip'], 10:21:29 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:21:29 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 10:21:29 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 10:21:29 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:21:29 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 10:21:29 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:21:29 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 10:21:29 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:21:29 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 10:21:29 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 10:21:29 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:21:29 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 10:21:29 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:21: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')]} 10:21:29 INFO - https://queue.taskcluster.net/v1/task/PwXC--t0Roa5fCt94ik59w/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:21:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwXC--t0Roa5fCt94ik59w/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:21:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwXC--t0Roa5fCt94ik59w/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:21:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwXC--t0Roa5fCt94ik59w/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:21:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwXC--t0Roa5fCt94ik59w/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:21:30 INFO - Downloaded 17829688 bytes. 10:21:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:21:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:21:33 INFO - Return code: 0 10:21:33 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 10:21: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')]} 10:21:33 INFO - https://queue.taskcluster.net/v1/task/PwXC--t0Roa5fCt94ik59w/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:21:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwXC--t0Roa5fCt94ik59w/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:21:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwXC--t0Roa5fCt94ik59w/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:21:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwXC--t0Roa5fCt94ik59w/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:21:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwXC--t0Roa5fCt94ik59w/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:21:34 INFO - Downloaded 17829688 bytes. 10:21:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:21:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:21:37 INFO - Return code: 0 10:21:37 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')]} 10:21:37 INFO - https://queue.taskcluster.net/v1/task/PwXC--t0Roa5fCt94ik59w/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 10:21:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwXC--t0Roa5fCt94ik59w/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 10:21:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwXC--t0Roa5fCt94ik59w/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 10:21:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwXC--t0Roa5fCt94ik59w/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 10:21:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwXC--t0Roa5fCt94ik59w/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:21:38 INFO - Downloaded 10707015 bytes. 10:21:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:21:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 10:21:39 INFO - Return code: 0 10:21:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:39 INFO - https://queue.taskcluster.net/v1/task/PwXC--t0Roa5fCt94ik59w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 10:21:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwXC--t0Roa5fCt94ik59w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 10:21:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwXC--t0Roa5fCt94ik59w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 10:21:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwXC--t0Roa5fCt94ik59w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 10:21:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwXC--t0Roa5fCt94ik59w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 10:21:42 INFO - Downloaded 111445990 bytes. 10:21:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PwXC--t0Roa5fCt94ik59w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 10:21:42 INFO - mkdir: /builds/slave/test/properties 10:21:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:21:42 INFO - Writing to file /builds/slave/test/properties/build_url 10:21:42 INFO - Contents: 10:21:42 INFO - build_url:https://queue.taskcluster.net/v1/task/PwXC--t0Roa5fCt94ik59w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 10:21:43 INFO - Running post-action listener: _resource_record_post_action 10:21:43 INFO - Running post-action listener: set_extra_try_arguments 10:21:43 INFO - ##### 10:21:43 INFO - ##### Running populate-webroot step. 10:21:43 INFO - ##### 10:21:43 INFO - Running pre-action listener: _resource_record_pre_action 10:21:43 INFO - Running main action method: populate_webroot 10:21:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:21:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:21:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:21:43 INFO - '--tppagecycles', 10:21:43 INFO - '7'], 10:21:43 INFO - 'tests': ['tsvgm']}}, 10:21:43 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:21:43 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:21:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:21:43 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 10:21:43 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:21:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:21:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:21:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:43 INFO - 'talos_options': ['--e10s'], 10:21:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:21:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:43 INFO - 'tests': ['damp', 'tps']}, 10:21:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:43 INFO - 'talos_options': ['--e10s'], 10:21:43 INFO - 'tests': ['damp', 'tps']}, 10:21:43 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:21:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:21:43 INFO - 'other': {'tests': ['a11yr', 10:21:43 INFO - 'ts_paint', 10:21:43 INFO - 'tpaint', 10:21:43 INFO - 'sessionrestore', 10:21:43 INFO - 'sessionrestore_no_auto_restore']}, 10:21:43 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:21:43 INFO - 'tests': ['a11yr', 10:21:43 INFO - 'ts_paint', 10:21:43 INFO - 'tpaint', 10:21:43 INFO - 'sessionrestore', 10:21:43 INFO - 'sessionrestore_no_auto_restore']}, 10:21:43 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:21:43 INFO - 'tests': ['a11yr', 10:21:43 INFO - 'ts_paint', 10:21:43 INFO - 'tpaint', 10:21:43 INFO - 'sessionrestore', 10:21:43 INFO - 'sessionrestore_no_auto_restore']}, 10:21:43 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:21:43 INFO - 'tests': ['a11yr', 10:21:43 INFO - 'ts_paint', 10:21:43 INFO - 'tpaint', 10:21:43 INFO - 'sessionrestore', 10:21:43 INFO - 'sessionrestore_no_auto_restore']}, 10:21:43 INFO - 'other_l64': {'tests': ['a11yr', 10:21:43 INFO - 'ts_paint', 10:21:43 INFO - 'tpaint', 10:21:43 INFO - 'sessionrestore', 10:21:43 INFO - 'sessionrestore_no_auto_restore']}, 10:21:43 INFO - 'other_nol64': {'tests': ['a11yr', 10:21:43 INFO - 'ts_paint', 10:21:43 INFO - 'tpaint', 10:21:43 INFO - 'sessionrestore', 10:21:43 INFO - 'sessionrestore_no_auto_restore']}, 10:21:43 INFO - 'svgr': {'tests': ['tsvgx', 10:21:43 INFO - 'tsvgr_opacity', 10:21:43 INFO - 'tart', 10:21:43 INFO - 'tscrollx', 10:21:43 INFO - 'cart']}, 10:21:43 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:21:43 INFO - 'tests': ['tsvgx', 10:21:43 INFO - 'tsvgr_opacity', 10:21:43 INFO - 'tart', 10:21:43 INFO - 'tscrollx', 10:21:43 INFO - 'cart']}, 10:21:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:43 INFO - 'tests': ['tp5o']}, 10:21:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:43 INFO - 'talos_options': ['--e10s'], 10:21:43 INFO - 'tests': ['tp5o']}, 10:21:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:43 INFO - 'talos_options': ['--xperf_path', 10:21:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:21:43 INFO - 'tests': ['tp5n']}, 10:21:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:43 INFO - 'talos_options': ['--e10s', 10:21:43 INFO - '--xperf_path', 10:21:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:21:43 INFO - 'tests': ['tp5n']}}, 10:21:43 INFO - 'talos.zip': {'path': '', 10:21:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:21:43 INFO - Running post-action listener: _resource_record_post_action 10:21:43 INFO - ##### 10:21:43 INFO - ##### Running create-virtualenv step. 10:21:43 INFO - ##### 10:21:43 INFO - Running pre-action listener: _resource_record_pre_action 10:21:43 INFO - Running main action method: create_virtualenv 10:21:43 INFO - Creating virtualenv /builds/slave/test/build/venv 10:21:43 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 10:21:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:21:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:21:43 INFO - Using real prefix '/tools/python27' 10:21:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:21:44 INFO - Installing distribute.............................................................................................................................................................................................done. 10:21:47 INFO - Installing pip.................done. 10:21:47 INFO - Return code: 0 10:21:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:21:47 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')]} 10:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:47 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')]} 10:21:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:47 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 0x10ba1ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba264c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7c8d93ab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8c2d30>, '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 0x10b6e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8b9b20>, '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.gGerKSmtfc/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.JMAsRxe77i/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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 10:21:47 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 10:21:47 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 10:21:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gGerKSmtfc/Render', 10:21:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:21:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:21:47 INFO - 'HOME': '/Users/cltbld', 10:21:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:21:47 INFO - 'LOGNAME': 'cltbld', 10:21:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:47 INFO - 'MOZ_NO_REMOTE': '1', 10:21:47 INFO - 'NO_EM_RESTART': '1', 10:21:47 INFO - 'PAGER': '/bin/cat', 10:21:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:21:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:47 INFO - 'PWD': '/builds/slave/test', 10:21:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:21:47 INFO - 'SHELL': '/bin/bash', 10:21:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JMAsRxe77i/Listeners', 10:21:47 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 10:21:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:21:47 INFO - 'USER': 'cltbld', 10:21:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:21:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:21:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:47 INFO - 'XPC_FLAGS': '0x0', 10:21:47 INFO - 'XPC_SERVICE_NAME': '0', 10:21:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:21:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:47 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 10:21:47 INFO - Cleaning up... 10:21:47 INFO - Return code: 0 10:21:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:21:47 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')]} 10:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:47 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')]} 10:21:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:47 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 0x10ba1ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba264c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7c8d93ab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8c2d30>, '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 0x10b6e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8b9b20>, '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.gGerKSmtfc/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.JMAsRxe77i/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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 10:21:47 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 10:21:47 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 10:21:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gGerKSmtfc/Render', 10:21:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:21:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:21:47 INFO - 'HOME': '/Users/cltbld', 10:21:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:21:47 INFO - 'LOGNAME': 'cltbld', 10:21:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:47 INFO - 'MOZ_NO_REMOTE': '1', 10:21:47 INFO - 'NO_EM_RESTART': '1', 10:21:47 INFO - 'PAGER': '/bin/cat', 10:21:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:21:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:47 INFO - 'PWD': '/builds/slave/test', 10:21:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:21:47 INFO - 'SHELL': '/bin/bash', 10:21:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JMAsRxe77i/Listeners', 10:21:47 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 10:21:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:21:47 INFO - 'USER': 'cltbld', 10:21:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:21:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:21:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:47 INFO - 'XPC_FLAGS': '0x0', 10:21:47 INFO - 'XPC_SERVICE_NAME': '0', 10:21:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:21:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:47 INFO - Downloading/unpacking psutil>=0.7.1 10:21: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 10:21: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 10:21: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 10:21: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 10:21: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 10:21: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 10:21:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:21:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:21:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:21:50 INFO - Installing collected packages: psutil 10:21:50 INFO - Running setup.py install for psutil 10:21:50 INFO - building 'psutil._psutil_osx' extension 10:21:50 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 10:21:51 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 10:21:51 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 10:21:51 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 10:21:51 INFO - building 'psutil._psutil_posix' extension 10:21:51 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 10:21:51 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:21:51 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:21:51 INFO - ^ 10:21:51 INFO - 1 warning generated. 10:21:51 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 10:21:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:21:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:21:51 INFO - Successfully installed psutil 10:21:51 INFO - Cleaning up... 10:21:51 INFO - Return code: 0 10:21:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:21:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:21:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:51 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 0x10ba1ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba264c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7c8d93ab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8c2d30>, '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 0x10b6e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8b9b20>, '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.gGerKSmtfc/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.JMAsRxe77i/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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 10:21:51 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 10:21:51 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 10:21:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gGerKSmtfc/Render', 10:21:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:21:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:21:51 INFO - 'HOME': '/Users/cltbld', 10:21:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:21:51 INFO - 'LOGNAME': 'cltbld', 10:21:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:51 INFO - 'MOZ_NO_REMOTE': '1', 10:21:51 INFO - 'NO_EM_RESTART': '1', 10:21:51 INFO - 'PAGER': '/bin/cat', 10:21:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:21:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:51 INFO - 'PWD': '/builds/slave/test', 10:21:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:21:51 INFO - 'SHELL': '/bin/bash', 10:21:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JMAsRxe77i/Listeners', 10:21:51 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 10:21:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:21:51 INFO - 'USER': 'cltbld', 10:21:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:21:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:21:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:51 INFO - 'XPC_FLAGS': '0x0', 10:21:51 INFO - 'XPC_SERVICE_NAME': '0', 10:21:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:21:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:21:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:21:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:21:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:21:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:21:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:21:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:21:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:21:54 INFO - Installing collected packages: mozsystemmonitor 10:21:54 INFO - Running setup.py install for mozsystemmonitor 10:21:54 INFO - Successfully installed mozsystemmonitor 10:21:54 INFO - Cleaning up... 10:21:54 INFO - Return code: 0 10:21:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:21:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:21:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:54 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 0x10ba1ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba264c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7c8d93ab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8c2d30>, '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 0x10b6e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8b9b20>, '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.gGerKSmtfc/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.JMAsRxe77i/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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 10:21:54 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 10:21:54 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 10:21:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gGerKSmtfc/Render', 10:21:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:21:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:21:54 INFO - 'HOME': '/Users/cltbld', 10:21:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:21:54 INFO - 'LOGNAME': 'cltbld', 10:21:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:54 INFO - 'MOZ_NO_REMOTE': '1', 10:21:54 INFO - 'NO_EM_RESTART': '1', 10:21:54 INFO - 'PAGER': '/bin/cat', 10:21:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:21:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:54 INFO - 'PWD': '/builds/slave/test', 10:21:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:21:54 INFO - 'SHELL': '/bin/bash', 10:21:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JMAsRxe77i/Listeners', 10:21:54 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 10:21:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:21:54 INFO - 'USER': 'cltbld', 10:21:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:21:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:21:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:54 INFO - 'XPC_FLAGS': '0x0', 10:21:54 INFO - 'XPC_SERVICE_NAME': '0', 10:21:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:21:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:54 INFO - Downloading/unpacking blobuploader==1.2.4 10:21: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 10:21: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 10:21: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 10:21: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 10:21: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 10:21: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 10:21:57 INFO - Downloading blobuploader-1.2.4.tar.gz 10:21:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:21:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:21: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 10:21: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 10:21: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 10:21: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 10:21: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 10:21: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 10:21:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:21:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:21: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 10:21: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 10:21: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 10:21: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 10:21: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 10:21: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 10:21:58 INFO - Downloading docopt-0.6.1.tar.gz 10:21:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:21:58 INFO - Installing collected packages: blobuploader, requests, docopt 10:21:58 INFO - Running setup.py install for blobuploader 10:21:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:21:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:21:58 INFO - Running setup.py install for requests 10:21:59 INFO - Running setup.py install for docopt 10:21:59 INFO - Successfully installed blobuploader requests docopt 10:21:59 INFO - Cleaning up... 10:21:59 INFO - Return code: 0 10:21:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:21:59 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')]} 10:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:59 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')]} 10:21:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:59 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 0x10ba1ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba264c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7c8d93ab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8c2d30>, '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 0x10b6e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8b9b20>, '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.gGerKSmtfc/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.JMAsRxe77i/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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 10:21:59 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 10:21:59 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 10:21:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gGerKSmtfc/Render', 10:21:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:21:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:21:59 INFO - 'HOME': '/Users/cltbld', 10:21:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:21:59 INFO - 'LOGNAME': 'cltbld', 10:21:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:59 INFO - 'MOZ_NO_REMOTE': '1', 10:21:59 INFO - 'NO_EM_RESTART': '1', 10:21:59 INFO - 'PAGER': '/bin/cat', 10:21:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:21:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:59 INFO - 'PWD': '/builds/slave/test', 10:21:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:21:59 INFO - 'SHELL': '/bin/bash', 10:21:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JMAsRxe77i/Listeners', 10:21:59 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 10:21:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:21:59 INFO - 'USER': 'cltbld', 10:21:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:21:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:21:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:59 INFO - 'XPC_FLAGS': '0x0', 10:21:59 INFO - 'XPC_SERVICE_NAME': '0', 10:21:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:21:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:21:59 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-n0cRHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:21:59 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-p7S12R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:21:59 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-QWay0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:21:59 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-N_kkcs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:22:00 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-dOzrzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:22:00 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-PhB7gA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:22:00 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-IcYcib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:22:00 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-H840nb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:22:00 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-1J53Kf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:22:00 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-ooxly9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:22:00 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-XPjxQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:22:00 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-QB56bz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:22:00 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-1TtBh5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:22:00 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-D4__t4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:22:01 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-3cxizA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:22:01 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-NvQ0VN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:22:01 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-7b2xMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:22:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:22:01 INFO - Running setup.py install for manifestparser 10:22:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:22:01 INFO - Running setup.py install for mozcrash 10:22:01 INFO - Running setup.py install for mozdebug 10:22:01 INFO - Running setup.py install for mozdevice 10:22:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:22:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:22:01 INFO - Running setup.py install for mozfile 10:22:02 INFO - Running setup.py install for mozhttpd 10:22:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:22:02 INFO - Running setup.py install for mozinfo 10:22:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:22:02 INFO - Running setup.py install for mozInstall 10:22:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:22:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:22:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:22:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:22:02 INFO - Running setup.py install for mozleak 10:22:02 INFO - Running setup.py install for mozlog 10:22:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:22:02 INFO - Running setup.py install for moznetwork 10:22:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:22:02 INFO - Running setup.py install for mozprocess 10:22:03 INFO - Running setup.py install for mozprofile 10:22:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:22:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:22:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:22:03 INFO - Running setup.py install for mozrunner 10:22:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:22:03 INFO - Running setup.py install for mozscreenshot 10:22:03 INFO - Running setup.py install for moztest 10:22:03 INFO - Running setup.py install for mozversion 10:22:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:22:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:22:03 INFO - Cleaning up... 10:22:03 INFO - Return code: 0 10:22:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:22:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:22:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:22:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:22:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22:04 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 0x10ba1ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba264c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7c8d93ab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8c2d30>, '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 0x10b6e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8b9b20>, '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.gGerKSmtfc/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.JMAsRxe77i/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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 10:22:04 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 10:22:04 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 10:22:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gGerKSmtfc/Render', 10:22:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:22:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:22:04 INFO - 'HOME': '/Users/cltbld', 10:22:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:22:04 INFO - 'LOGNAME': 'cltbld', 10:22:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:22:04 INFO - 'MOZ_NO_REMOTE': '1', 10:22:04 INFO - 'NO_EM_RESTART': '1', 10:22:04 INFO - 'PAGER': '/bin/cat', 10:22:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:22:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:22:04 INFO - 'PWD': '/builds/slave/test', 10:22:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:22:04 INFO - 'SHELL': '/bin/bash', 10:22:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JMAsRxe77i/Listeners', 10:22:04 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 10:22:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:22:04 INFO - 'USER': 'cltbld', 10:22:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:22:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:22:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:22:04 INFO - 'XPC_FLAGS': '0x0', 10:22:04 INFO - 'XPC_SERVICE_NAME': '0', 10:22:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:22:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:22:04 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-QRxaGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:22:04 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)) 10:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:22:04 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-eVcTk4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:22:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 10:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:22:04 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-ztZRiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:22:04 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)) 10:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:22:04 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-eNzr3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:22:05 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)) 10:22:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:22:05 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-kVeqsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:22:05 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)) 10:22:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:22:05 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-NwNbqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:22:05 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)) 10:22:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:22:05 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-nrn29m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:22:05 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)) 10:22:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:22:05 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-mzTCfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:22:05 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)) 10:22:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:22:05 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-iuRXpW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:22:05 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)) 10:22:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:22:05 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-8uvHcv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:22:05 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)) 10:22:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:22:05 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-tZSF_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:22:05 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)) 10:22:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:22:05 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-jDZcgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:22:05 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)) 10:22:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:22:05 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-9JSFUV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:22:06 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)) 10:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:22:06 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-8Q3tT2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:22:06 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)) 10:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:22:06 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-2VJaIm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:22:06 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)) 10:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:22:06 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-zaKol7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:22:06 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)) 10:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:22:06 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-2AFL2v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:22:06 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)) 10:22:06 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:22:06 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:22:06 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)) 10:22:06 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)) 10:22:06 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)) 10:22:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:22:06 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 10:22:06 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 10:22:06 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 10:22:06 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 10:22:06 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 10:22:06 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 10:22:09 INFO - Downloading blessings-1.6.tar.gz 10:22:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:22:09 INFO - Installing collected packages: blessings 10:22:09 INFO - Running setup.py install for blessings 10:22:09 INFO - Successfully installed blessings 10:22:09 INFO - Cleaning up... 10:22:09 INFO - Return code: 0 10:22:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:22:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:22:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:22:09 INFO - Reading from file tmpfile_stdout 10:22:09 INFO - Current package versions: 10:22:09 INFO - blessings == 1.6 10:22:09 INFO - blobuploader == 1.2.4 10:22:09 INFO - docopt == 0.6.1 10:22:09 INFO - manifestparser == 1.1 10:22:09 INFO - mozInstall == 1.12 10:22:09 INFO - mozcrash == 0.16 10:22:09 INFO - mozdebug == 0.1 10:22:09 INFO - mozdevice == 0.48 10:22:09 INFO - mozfile == 1.2 10:22:09 INFO - mozhttpd == 0.7 10:22:09 INFO - mozinfo == 0.9 10:22:09 INFO - mozleak == 0.1 10:22:09 INFO - mozlog == 3.1 10:22:09 INFO - moznetwork == 0.27 10:22:09 INFO - mozprocess == 0.22 10:22:09 INFO - mozprofile == 0.28 10:22:09 INFO - mozrunner == 6.11 10:22:09 INFO - mozscreenshot == 0.1 10:22:09 INFO - mozsystemmonitor == 0.0 10:22:09 INFO - moztest == 0.7 10:22:09 INFO - mozversion == 1.4 10:22:09 INFO - psutil == 3.1.1 10:22:09 INFO - requests == 1.2.3 10:22:09 INFO - wsgiref == 0.1.2 10:22:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:22: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')]} 10:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:22:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22: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')]} 10:22:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:22:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22:09 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 0x10ba1ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba264c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7c8d93ab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8c2d30>, '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 0x10b6e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8b9b20>, '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.gGerKSmtfc/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.JMAsRxe77i/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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 10:22:09 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 10:22:09 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 10:22:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gGerKSmtfc/Render', 10:22:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:22:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:22:09 INFO - 'HOME': '/Users/cltbld', 10:22:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:22:09 INFO - 'LOGNAME': 'cltbld', 10:22:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:22:09 INFO - 'MOZ_NO_REMOTE': '1', 10:22:09 INFO - 'NO_EM_RESTART': '1', 10:22:09 INFO - 'PAGER': '/bin/cat', 10:22:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:22:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:22:09 INFO - 'PWD': '/builds/slave/test', 10:22:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:22:09 INFO - 'SHELL': '/bin/bash', 10:22:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JMAsRxe77i/Listeners', 10:22:09 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 10:22:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:22:09 INFO - 'USER': 'cltbld', 10:22:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:22:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:22:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:22:09 INFO - 'XPC_FLAGS': '0x0', 10:22:09 INFO - 'XPC_SERVICE_NAME': '0', 10:22:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:22:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:22:10 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)) 10:22:10 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)) 10:22:10 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)) 10:22:10 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)) 10:22:10 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)) 10:22:10 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)) 10:22:10 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)) 10:22:10 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)) 10:22:10 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)) 10:22:10 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)) 10:22:10 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)) 10:22:10 INFO - Cleaning up... 10:22:10 INFO - Return code: 0 10:22:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:22: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')]} 10:22:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:22:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22: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')]} 10:22:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:22:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ba1ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba264c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7c8d93ab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8c2d30>, '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 0x10b6e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8b9b20>, '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.gGerKSmtfc/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.JMAsRxe77i/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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 10:22:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:22:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:22:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gGerKSmtfc/Render', 10:22:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:22:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:22:10 INFO - 'HOME': '/Users/cltbld', 10:22:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:22:10 INFO - 'LOGNAME': 'cltbld', 10:22:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:22:10 INFO - 'MOZ_NO_REMOTE': '1', 10:22:10 INFO - 'NO_EM_RESTART': '1', 10:22:10 INFO - 'PAGER': '/bin/cat', 10:22:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:22:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:22:10 INFO - 'PWD': '/builds/slave/test', 10:22:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:22:10 INFO - 'SHELL': '/bin/bash', 10:22:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JMAsRxe77i/Listeners', 10:22:10 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 10:22:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:22:10 INFO - 'USER': 'cltbld', 10:22:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:22:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:22:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:22:10 INFO - 'XPC_FLAGS': '0x0', 10:22:10 INFO - 'XPC_SERVICE_NAME': '0', 10:22:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:22:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:22:10 INFO - Downloading/unpacking jsonschema 10:22:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:22:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:22:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:22:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:22:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:22:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:22:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:22:12 INFO - Downloading/unpacking functools32 (from jsonschema) 10:22:12 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 10:22:12 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 10:22:12 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 10:22:12 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 10:22:12 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 10:22:12 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 10:22:13 INFO - Downloading functools32-3.2.3-2.tar.gz 10:22:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:22:13 INFO - warning: no files found matching '*.txt' 10:22:13 INFO - no previously-included directories found matching 'build' 10:22:13 INFO - no previously-included directories found matching 'dist' 10:22:13 INFO - no previously-included directories found matching '.git*' 10:22:13 INFO - Installing collected packages: jsonschema, functools32 10:22:13 INFO - Running setup.py install for functools32 10:22:13 INFO - warning: no files found matching '*.txt' 10:22:13 INFO - no previously-included directories found matching 'build' 10:22:13 INFO - no previously-included directories found matching 'dist' 10:22:13 INFO - no previously-included directories found matching '.git*' 10:22:13 INFO - Successfully installed jsonschema functools32 10:22:13 INFO - Cleaning up... 10:22:13 INFO - Return code: 0 10:22:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:22:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:22:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:22:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:22:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:22:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ba1ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba264c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7c8d93ab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8c2d30>, '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 0x10b6e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8b9b20>, '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.gGerKSmtfc/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.JMAsRxe77i/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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 10:22:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:22:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:22:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gGerKSmtfc/Render', 10:22:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:22:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:22:13 INFO - 'HOME': '/Users/cltbld', 10:22:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:22:13 INFO - 'LOGNAME': 'cltbld', 10:22:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:22:13 INFO - 'MOZ_NO_REMOTE': '1', 10:22:13 INFO - 'NO_EM_RESTART': '1', 10:22:13 INFO - 'PAGER': '/bin/cat', 10:22:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:22:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:22:13 INFO - 'PWD': '/builds/slave/test', 10:22:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:22:13 INFO - 'SHELL': '/bin/bash', 10:22:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JMAsRxe77i/Listeners', 10:22:13 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 10:22:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:22:13 INFO - 'USER': 'cltbld', 10:22:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:22:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:22:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:22:13 INFO - 'XPC_FLAGS': '0x0', 10:22:13 INFO - 'XPC_SERVICE_NAME': '0', 10:22:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:22:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:22:13 INFO - Downloading/unpacking flake8 10:22:13 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 10:22:13 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 10:22:13 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 10:22:13 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 10:22:13 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 10:22:13 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 10:22:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:22:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:22:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:22:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:22:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:22:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:22:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:22:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:22:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:22:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:22:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:22:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:22:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:22:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:22:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:22:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:22:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:22:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:22:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:22:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:22:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:22:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:22:17 INFO - no previously-included directories found matching 'docs/_build' 10:22:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:22:17 INFO - Running setup.py install for pep8 10:22:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:22:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:22:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:22:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:22:17 INFO - no previously-included directories found matching 'docs/_build' 10:22:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:22:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:22:17 INFO - Cleaning up... 10:22:17 INFO - Return code: 0 10:22:17 INFO - Running post-action listener: _resource_record_post_action 10:22:17 INFO - Running post-action listener: _start_resource_monitoring 10:22:17 INFO - Starting resource monitoring. 10:22:17 INFO - ##### 10:22:17 INFO - ##### Running install step. 10:22:17 INFO - ##### 10:22:17 INFO - Running pre-action listener: _resource_record_pre_action 10:22:17 INFO - Running main action method: install 10:22:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:22:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:22:17 INFO - Reading from file tmpfile_stdout 10:22:17 INFO - Detecting whether we're running mozinstall >=1.0... 10:22:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:22:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:22:18 INFO - Reading from file tmpfile_stdout 10:22:18 INFO - Output received: 10:22:18 INFO - Usage: mozinstall [options] installer 10:22:18 INFO - Options: 10:22:18 INFO - -h, --help show this help message and exit 10:22:18 INFO - -d DEST, --destination=DEST 10:22:18 INFO - Directory to install application into. [default: 10:22:18 INFO - "/builds/slave/test"] 10:22:18 INFO - --app=APP Application being installed. [default: firefox] 10:22:18 INFO - mkdir: /builds/slave/test/build/application 10:22:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:22:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 10:22:52 INFO - Reading from file tmpfile_stdout 10:22:52 INFO - Output received: 10:22:52 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:22:52 INFO - Running post-action listener: _resource_record_post_action 10:22:52 INFO - ##### 10:22:52 INFO - ##### Running run-tests step. 10:22:52 INFO - ##### 10:22:52 INFO - Running pre-action listener: _resource_record_pre_action 10:22:52 INFO - Running main action method: run_tests 10:22:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:22:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:22:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:22:52 INFO - 2016-02-25 10:22:52.088 screenresolution[1656:7524] starting screenresolution argv=screenresolution get 10:22:52 INFO - 2016-02-25 10:22:52.090 screenresolution[1656:7524] Display 0: 1600x1200x32@60 10:22:52 INFO - 2016-02-25 10:22:52.096 screenresolution[1657:7526] starting screenresolution argv=screenresolution list 10:22:52 INFO - Available Modes on Display 0 10:22:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:22:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:22:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:22:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:22:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:22:52 INFO - Intel Iris: 10:22:52 INFO - Chipset Model: Intel Iris 10:22:52 INFO - Type: GPU 10:22:52 INFO - Bus: Built-In 10:22:52 INFO - VRAM (Dynamic, Max): 1536 MB 10:22:52 INFO - Vendor: Intel (0x8086) 10:22:52 INFO - Device ID: 0x0a2e 10:22:52 INFO - Revision ID: 0x0009 10:22:52 INFO - Displays: 10:22:52 INFO - Display: 10:22:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:22:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:22:52 INFO - Display Serial Number: 1600x1200 60 10:22:52 INFO - Main Display: Yes 10:22:52 INFO - Mirror: Off 10:22:52 INFO - Online: Yes 10:22:52 INFO - Rotation: Supported 10:22:52 INFO - Return code: 0 10:22:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:22:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:22:52 INFO - Python 2.7.3 10:22:52 INFO - Return code: 0 10:22:52 INFO - grabbing minidump binary from tooltool 10:22:52 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')]} 10:22:52 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 0x10b8c2d30>, '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 0x10b6e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8b9b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:22:52 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 10:22:52 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 10:22:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:22:52 INFO - Return code: 0 10:22:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:22:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:22:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:22:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:22:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:22:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:22:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:22:53 INFO - Return code: 0 10:22:53 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/PwXC--t0Roa5fCt94ik59w/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0160', '--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 10:22:53 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/PwXC--t0Roa5fCt94ik59w/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0160 --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 10:22:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gGerKSmtfc/Render', 10:22:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:22:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:22:53 INFO - 'HOME': '/Users/cltbld', 10:22:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:22:53 INFO - 'LOGNAME': 'cltbld', 10:22:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:22:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:22:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:22:53 INFO - 'MOZ_NO_REMOTE': '1', 10:22:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:22:53 INFO - 'NO_EM_RESTART': '1', 10:22:53 INFO - 'PAGER': '/bin/cat', 10:22:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:22:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:22:53 INFO - 'PWD': '/builds/slave/test', 10:22:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:22:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:22:53 INFO - 'SHELL': '/bin/bash', 10:22:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JMAsRxe77i/Listeners', 10:22:53 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 10:22:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:22:53 INFO - 'USER': 'cltbld', 10:22:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:22:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:22:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:22:53 INFO - 'XPC_FLAGS': '0x0', 10:22:53 INFO - 'XPC_SERVICE_NAME': '0', 10:22:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:22:53 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/PwXC--t0Roa5fCt94ik59w/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0160', '--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 10:22:53 INFO - mozversion application_buildid: 20160225084244 10:22:53 INFO - mozversion application_changeset: 17ba8c582eba5fb32809f1480867c200f69b5e2f 10:22:53 INFO - mozversion application_display_name: Nightly 10:22:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:22:53 INFO - mozversion application_name: Firefox 10:22:53 INFO - mozversion application_remotingname: firefox 10:22:53 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:22:53 INFO - mozversion application_vendor: Mozilla 10:22:53 INFO - mozversion application_version: 47.0a1 10:22:53 INFO - mozversion platform_buildid: 20160225084244 10:22:53 INFO - mozversion platform_changeset: 17ba8c582eba5fb32809f1480867c200f69b5e2f 10:22:53 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:22:53 INFO - mozversion platform_version: 47.0a1 10:22:53 INFO - using testdate: 1456424573 10:22:53 INFO - actual date: 1456424573 10:22:54 INFO - starting webserver on 'localhost:49274' 10:22:54 INFO - SUITE-START | Running 2 tests 10:22:54 INFO - TEST-START | dromaeo_css 10:22:54 INFO - operating with platform_type : mac_ 10:22:54 INFO - Initialising browser for dromaeo_css test... 10:22:54 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/tmps6xPb4/profile http://localhost:49274/getInfo.html) 10:22:56 INFO - PROCESS | 1675 | __metrics Screen width/height:1600/1200 10:22:56 INFO - PROCESS | 1675 | colorDepth:24 10:22:56 INFO - PROCESS | 1675 | Browser inner width/height: 1024/689 10:22:56 INFO - PROCESS | 1675 | __metrics 10:22:56 INFO - PROCESS | 1675 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:22:56 INFO - PROCESS | 1675 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:22:57 INFO - TEST-INFO | 1675: exit 0 10:22:57 INFO - Browser initialized. 10:22:57 INFO - Running cycle 1/1 for dromaeo_css test... 10:22:57 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/tmps6xPb4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:23:09 INFO - PROCESS | 1678 | RSS: Main: 244486144 10:23:09 INFO - PROCESS | 1678 | 10:24:00 INFO - PROCESS | 1678 | 1456424640499 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] 10:26:11 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 10:26:12 INFO - PROCESS | 1678 | RSS: Main: 378765312 10:26:12 INFO - PROCESS | 1678 | 10:29:14 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 10:29:15 INFO - PROCESS | 1678 | RSS: Main: 382414848 10:29:15 INFO - PROCESS | 1678 | 10:32:17 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 10:32:18 INFO - PROCESS | 1678 | RSS: Main: 381677568 10:32:18 INFO - PROCESS | 1678 | 10:35:20 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 10:35:20 INFO - PROCESS | 1678 | RSS: Main: 333033472 10:35:20 INFO - PROCESS | 1678 | 10:38:23 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 10:38:24 INFO - PROCESS | 1678 | RSS: Main: 337498112 10:38:24 INFO - PROCESS | 1678 | 10:41:27 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 10:41:27 INFO - PROCESS | 1678 | RSS: Main: 381952000 10:41:27 INFO - PROCESS | 1678 | 10:41:27 INFO - PROCESS | 1678 | __start_tp_report 10:41:27 INFO - PROCESS | 1678 | _x_x_mozilla_page_load 10:41:27 INFO - PROCESS | 1678 | _x_x_mozilla_page_load_details 10:41:27 INFO - PROCESS | 1678 | |i|pagename|runs| 10:41:27 INFO - PROCESS | 1678 | |0;dojo.html;3420.811855347956;3430.708389786868;3452.2750222453283;3473.583170019598;3508.7193024558037;5551.639143455683;5585.720713964306;5606.579506537011;5609.775608975636;5635.6618602883855;5571.9721401392935;5616.185653080301;5637.069883469233;5640.633358831673;5641.294838145232;5095.235714642796;5121.923171152435;5142.997115562467;5156.355455568054;5204.089284375238;5200.167973124301;5201.973990130044;5209.635325527214;5210.973945130269;5216;5176.8446946591475;5198.896022079556;5205.115130427817;5215.608829337796;5230.398504172012;5160.277561141444;5198.92201616976;5203.635745497817;5213.791448342062;5260.736963151827;5066.771995260222;5072.873178170538;5089.134847076006;5135.512126347991;5145.588352931794;4817.951820481785;5509.586780991442;5509.834704958857;5515.310586176728;5565.1374037024325;6128.7242074106325;6157.107219453154;6159.168512250833;6159.661218632973;6161.599496032743;6089.924588083034;6105.511559075308;6183.1961844960315;6192.442680158762;6200.286966998808;5804.071348584206;5814.97092514539;5817.447342502455;5836.824895253149;5848.3274423441;6213.03697926822;6214.627122372672;6219.036049412348;6223.315435302113;6315.873682526324;5951.702414879239;5982.312034116046;6062.575619706578;6100.969495152496;6107.603005804697;6111.505911234519;6131.110988906584;6143.723532441051;6164.4760195383;6175.413335733098;6098.480339642134;6119.296280927661;6138.846528836815;6145.723442445101;6146.8935591593945;6036.215292012011;6115.052166914135;6118.3269840317525;6130.049842274455;6134;4811.663183577186;4821.590164836029;4827.710337379698;4832.275158726149;4851.0055438635;4326.524082351002;4388.868333949987;4410.33844923264;4418.690691651618;4422.624076953431;5564.554835613141;5602.411746766531;5612.7754889803955;5620.1288800236025;5620.381758006616;6174.722137503823;6177.073438984098;6186.566940314135;6204.162438070803;6214;5499.835004949858;5569.888602227933;5581.720913954286;5593.07714227148;5607.943920560742;5242.7640756166065;5257.0274499217;5258.2112683097075;5264.92102618461;5283.709395983258;6115.818436018264;6124.045297608125;6166.105914642351;6189.50483961282;6190.102435146879;5162.612804039637;6153.630782153085;6173.629582225081;6185.783497577563;6187.226596675416;6231.9688401557705;6239.126522286974;6259.749610015549;6265.8120256392385;6269.059641053878;5556.777728890799;5686.175504551899;6036.154938308729;6042;6070.089486577049;6140.228185505789;6175.876482470415;6180.5673602849165;6186.721597528212;6187.938120618736;6008.489278411209;6057.091436284592;6057.091436284592;6080.72636731357;6091.177691011657;4530.796114174936;5891.469767720926;5999.700014999145;6067.787627433018;6076.605020673642;5897.734601942837;5908.793192238251;5917.822465326047;5944.227250457413;5962.880742385041;5018.473060328759;5987.101934709828;6024.156618073561;6032.366601506778;6041.607295525777;5746.626469279484;5805.8548536286935;5914.112883067574;5918.585699001201;5935.317438494629 10:41:27 INFO - PROCESS | 1678 | |1;ext.html;481.40065618305215;552.8031811128903;556;559.6921693068813;592.8054969236986;29289.56065659017;37544.62455375445;37580;37668.246635067284;37794.43308350373;40118.79940600293;40440;40614.18771624566;40656;40754.38868416976;7873.212678732139;9449.102335278138;9450.102240287162;9457;9472.763180920463;9346.859797103049;9483.66807161746;9508.429494230368;9515.143637072662;9518.524073796318;9554.331196816225;9654.324197306192;9661.95169024154;9674.516274186262;9729.270304727139;9583.089606487372;9610.135087842058;9611.134997850157;9631.3258071935;9677.080677335642;9408.247340212767;9563.856542151872;9565.760855978657;9567.760805979837;9583.137517623447;38918;39313.803430982945;39329.80335098335;39366.015849603704;39379;3148.464760990637;3224.6130464344196;3290.9506357404657;3476.89569312921;3681.1349332906743;27668.031618893445;27934.580981285297;28098.719012809815;28566.857325706947;28698.856505717336;2705.878235479408;2745.7254274572383;2747.189579074178;2793.8463384513843;2837.65948086231;484733;486437.97467088833;488731;488741;488803;35420.99999999948;44615;59852.401475985556;60242;60349.09476357858;43189.13621727548;43270.35094473585;43453.13093738107;43468.56531434645;43502;14925.850741492663;15112.848871511364;15119.319630616648;15126.773098403533;15149;12141.635750927486;12226.877731222574;12232.877671223352;12236.694082648006;12254.509819607116;12088.697782555506;14251.57245282643;14277.000609957204;14307.856921430652;14387.496437624633;6228.875422491616;6317.873642527124;6357.205349331333;6359.141515895388;6375.968120159369;906.7959709065408;983.9803203935882;1017.8167929772712;1054.947252637365;1131.4682099413262;23913.402164946016;28692.856535717186;29400.7059929398;29484.557731634042;29486.705132948824;859.6217664227845;1046.8063408269495;1055.630529314749;1073.63496411219;1159.3623507071077;15345.846541534665;15433.922830385776;15447.0731756095;15751.527454176394;15823.604409889615;597687;653584;662521;662663;663689;57992.71003644955;58590.121148182814;58688;58816.70591647014;58822.99999999914;1274.0635632809876;1303.863094375096;1401.628568429367;1425.322971588508;1553.1845780965084;23859.403514912265;26523.734762652126;28350.007749728662;28417;28684.852605896365;46022.079558409314;46131.077378452916;46708.76645616886;46743.76628116838;46816;356950;357050;360144;360209;360760;31356.529652055695;31710.68289317077;31739.84130079335;32302.83848580742;32371.028869133963;41644;41915.53295634638;42125.36811947762;42878.71363859089;43016;31203.219919502193;31712.207194820316;34480.48279275863;35358;35524.82237588899;34623.307533849686;34693.95918122461;35136.64863351334;35235.64764352426;35510.82244588761;34285;34598.827005865816;34784.47823282602;35038.47442288419;35381;24503;28403.573946391232;29565.965191218205;30906.227344316572;30921.536176956914;23353.76646233516;23649.763502364756;23790.40523986845;23965.76034239705;24003.79981000978 10:41:27 INFO - PROCESS | 1678 | |2;jquery.html;352.0758010223164;353.2704964248826;356.2056613751335;361.0792479178098;362.3314983854787;19193.232270709173;19640;21338.146474141053;21389.0374933128;21406.785932140694;20235;20635.587288254224;20932.476688082807;20950.16199352024;20965.580688386224;5718.513926316257;6037.788677396292;6041.939580604204;6043.244594425697;6073.3622969588;4136.834526618932;5902.97048514759;6265.373462653721;6538.313477084909;6544.770933017346;5476.726163691819;6480.805575832709;6482.222133344006;6482.708278127472;6488.610683359014;5505.449455054502;5676.602637815355;5705.115707065412;5739.684317362543;5750.166225897264;3807.733458657895;6939.757108501179;7226.963865180693;7241.927580724178;7252.8549429011655;25826;26976.246543974776;27386.45227095447;27810.582841257397;27927.720722792918;2223.5775202711434;2322.5935461294207;2482.6276058591175;2501.474690315018;2989.626296712911;14689.005738049114;14945.850541494663;15163.924180379028;15693.607659808597;15715.135667538281;1806.8554515638718;1828.9085545722794;1866.9906650466796;1924.6728056230475;2016.2539860251654;115149.42425287903;125282.74717252802;125589;125589.37205314006;126465.36767316105;19098.71351929722;19276.84338939668;19501.024948752507;19518.414447566596;19621.411357659294;28796;29005;29047.41905161885;29059.854700726362;29139.562906556417;10427.322224055411;10693.679189624323;10696.037356637784;10706.625268115735;10825.458727063773;9130.452172869649;9132.360734748503;9134.634614615341;9220.077992200726;9241.61375793623;8625.827483450421;8655.740327790176;8743.431676940978;8763.649454021768;8777.166169213915;2312.9884350578477;3333.0500807269814;3395.303962687643;3537.133402316449;3581.301646179022;698.8218004408944;784.6429874407131;822.6956026270318;972.5234635028785;1035.6634093919356;19535;20322.796772032092;20400.795992040188;20445.488862778253;20611;913.3834661603391;938.3384713776908;950.1591091883732;960.8894977077586;968.6803354892868;10351.534180961875;10851.131909447226;10985;11013.339199648046;11112.722181945515;534874;555043;556053;557614;587443;118770.81229187771;120801.39599302123;121020;121258.3937080309;122457.38771306086;992.8014397120605;996.6760802739138;1009.6668099527138;1011.0698157694939;1030.1346868630237;17840.643187135924;18127.637447250716;18279.54301142482;18294.26822927068;18642.254309827455;50809;51689.741551292005;51737.706557336365;52579.47420525746;53635.463645363045;54782.726086369315;57486;71448.64275678588;74695.25304746882;77424;7901.802454938673;8030.558319292495;8114.918850811652;8163.26530612224;8427.41008129425;9317.953410232905;12375.69060773488;12793.680157996125;12861.678458038625;13337.466501339837;9498.052899155795;10741.355518668905;11131.332120072822;11657.242279251821;11779.528818847493;10545.261831671709;10814.080803131821;11191.888081119085;11253.381064041556;11564.537418503165;11414;11695.941520292345;11705.88294117048;11730.70673233176;11779.234349767237;7970.1631328709655;8140;8152.103268640326;8209.261166495044;8309.626066827128;10900;11361.091112711129;11490;11526.769464610828;11753.412329383667 10:41:27 INFO - PROCESS | 1678 | |3;mootools.html;1311.2853494845308;1379.4757991963052;1529.5182017664436;1698.4904528641405;1931.053783646013;6935.375816176543;7649.349805266552;8368.330533557317;8375.329973602113;8387.077421483631;8075.676972921076;8327.125651806564;8335.58322083895;8341.165883411655;8341.33269338453;2142.5714857028656;2346.577616029114;2401.3636386357584;2407.8555286682767;2431.2463136427677;2422;2428.6842710447618;2428.9028438862424;2429.647701083342;2431.7932975697086;2367.1951536477595;2374.5250949810106;2424.87875606219;2431.404305945046;2431.8662473563945;2385.200957679171;2426.4176597616533;2430.902763889442;2431.234161239213;2433.063270640816;2397.0771253067696;2418.6492958520917;2427.7693619106335;2429.149797570854;2440.9145679901117;8402.075771665111;8496.915030849674;8500.829983400297;8508.74473765788;8509.276711479532;5207.958408318314;5353.973230133864;5359.276497672803;5361.437049109826;5361.892762144775;3519.2433626770367;3551.1122219445137;3629.5281613390353;3688.5942546319884;3689.409694448902;1037.5175543372293;1046.9685909422728;1049.7060822969581;1059.5973530058604;1062.5696592879897;11306.830397544043;11320.377379244139;11323.490442930006;11332.43337833105;11334.149938754545;4682.789274482657;4740.3837501124635;4801.087793319258;4814.253790662453;4816.735079570587;9754.02459754033;9791.853122203172;9795.510224488748;9802.166815820592;9808.362456440309;5280.603954703336;5320.627556071038;5321.36143662763;5323.520883120537;5325.813596524181;4285.721428107163;4442;4689.50760170184;4738.881527961759;4783.904321913612;3217.2761128745847;3764.6047165047275;3865.381538953754;3881.243157584244;3918.7060970427333;1281.4745954158936;1291.3930452687223;1294.6504443800309;1297.8247936528637;1310.331730817271;1285.5436320106414;1295.4623831109984;1316.2760481735008;1329.2622594460167;1329.5147271245926;7847.686092556348;7909.446338756347;7943.563104029218;7946.682132714626;7948.960255198803;503.0643004012534;513.1404896797849;514.9639525233273;516.5712458659303;517.1880148167342;6061.696915154224;6103.389661033861;6109.84725381869;6119;6121.418465245794;9734.951325243328;9982.800343993225;10067.395956242503;10122.443265620313;10143.137833284105;9604.567794449267;9989.200863930868;10000.349977251455;10002.249831262685;10033.548490317953;7747.225277472207;7919.762407127795;7920.564368959763;7993.320567751806;8013.559254241072;7737.381009519112;7745.7676269712;7829.138794732688;7844.84310313802;7912.406569507195;9049.366544341832;9259.074092590687;9342.486163261086;9374.484403357881;9439.528023598656;9332.626694932398;9581;9677.806443870943;9708.5145742714;9742.171915386987;6667.266600674019;6842.589444633338;7075.71697132109;7313.524620899624;7433.8141546461775;6704.698288577123;7988.121306656147;8017.398695097774;8021.077576078826;8028.07677117139;6702.530822842355;6841.350071743176;6843.863122737617;6925.030495730501;7009.404200642798;6962.7214911405;6994.440444764508;7060.71757129709;7107.573545587281;7148.606826624586;6357.523185761179;7429.368503677248;7463.477556570988;7531.962340188264;7555.09338879338;6743.7302507901095;6754.831129221809;6818.965905170442;6823;6836.897446538405;6670.764064818778;6875.5530890491955;6885.036094946811;6927.6882540286815;6951.991961165704 10:41:27 INFO - PROCESS | 1678 | |4;prototype.html;313.373253493014;321.04169055369715;324.94963280691496;329.3215975091312;332.14472732713267;5413.808962028347;6498.805035848926;6551.901721474176;6612.875811112104;6624.807534643762;6389.297177310492;6478.935210647892;6487.253965793935;6512.218533775954;6515.120458738069;4676.111538807624;4747.145513807513;4794.856154315376;4897.534734200245;4906.877328066791;4870.391201099863;4920.60635149189;4941.085899108659;4942.6293028022865;4943.901121977558;4646.790894409743;4884.096442158194;4896.069746748124;4899.975500122512;4902.240152776308;4680.648951328647;4775.928361074587;4780.139574876521;4784.306275590037;4798.1123492154065;4102.323116685743;4110.095778928631;4119.711620186588;4120.587941205856;4125.50493940729;6246.562740608159;6319.336469670664;6335.461485773715;6353.841153971188;6356.682165891733;5695.088785794294;5720.771169153229;5723.771049158028;5725.141228815669;5732.942670573282;6804.863902721918;7013.544119632207;7032.156141263081;7041.753538626123;7052.153741550996;3853.9229215415535;4478.865634030984;4525.366448697185;4530.524294949016;4534.31985202219;7321.487495875291;7397.70409183632;7412.962185294063;7430.6284685765495;7450.776476705708;4591.517890621503;4599.655025873073;4600.723956562617;4606.309053641913;4608.055348653518;4661.298626001553;4664.930026049544;4672.275797251364;4678.836240731558;4681.81272749093;5594.468525490072;5596.3284405870745;5598.720063996784;5598.916016259759;5602.551795856321;6857.108575885203;7126.394256488256;7138.321859423347;7154.4634152438775;7169.24722904098;1587.396789220089;1626.951191464258;1628.6335574495645;1628.8452597003266;1634.5014770495113;834.3241974001079;969.7963427680126;1004.3070281505884;1033.720895358264;1036.7770929250248;5904.3210030847;6394.712237949303;6462.38607332312;6588.209414870246;6678.9332106679285;5987;7429.36850367714;7431.182569917305;7441.85116297671;7465.141508726566;6550.70521826519;6564.80305590833;6571.408573228432;6571.868562628721;6574.76988305407;3890.6498415142773;3935.2719746846924;3941.6452519273403;3943.7830919299713;3948.9210215795524;7434.145073316529;7661.808454788675;7711.113221979432;7777;7792.922070779219;7637.15991240963;7660.961695191489;7684.46208765381;7693.346065584376;7693.846123077507;7729.961350193325;7735.574543400167;7737.342325902361;7739.1873853245725;7739.419543534144;7139;7428.777136685908;7429.8142546436775;7430.888536672062;7444.925550744423;7235.204127546071;7290.854182916418;7297.890531641923;7309.415246780139;7333.413326933725;7720.575368354795;7725.845483090419;7733.265339792711;7745.922540774745;7765.107012693613;4581.1753884299815;4642.2340313847835;4645.279981602857;4652.837150699709;4658.068386322817;5999.1901093351835;7113.75101871432;7302.671379788028;7391.2239214881665;7400.444966627417;6053.878922421615;6918.135233095863;7093.82265443368;7155.212926578176;7166.175889772534;5749.367569567428;7126.643667816692;7131.465140114616;7148.0350152728715;7150.320719531636;6960.512764106464;6975;6995.440364770908;6999.650017499206;7001.334873187039;6837.658117094026;7149.319909821292;7149.392301654418;7168;7168.498205125591;6694.096296999843;6795.694193761392;6830.7609233676585;7002.089728335284;7009.684564194521 10:41:27 INFO - PROCESS | 1678 | |5;yui.html;634.1977398590782;730.247844719938;733.4205977277949;751.7105914223023;770.1489853711652;14612.415503379865;14830.332635031422;14842.33209505572;14848;14877.404903803836;13394.12938159019;13407.19556826591;13415;13450.327483625828;13637.977151713612;696.7178292791427;850.9276711479516;866.0213958227195;866.4757821517954;867.5618812499711;699.9545029573087;701.1200942816757;703.0543918429704;703.7255470366562;828.056016141599;799.3645052183499;900.7973206028624;905.4024343933006;905.5924833824772;906.1029580715077;896.4173287363201;900.7567956651733;901.9188273055423;902.2421166220373;902.41794042842;542.5578153804637;653.2455014458309;660.9919872194893;667.4927055437854;667.8363800868818;14649.780253296209;14684.559463216014;14697.191654459;14713.852861471356;14717.632059198499;10569.577216911315;12206.877931220663;12316.568920087844;12367.134300598962;12646.873531264662;9954.701358959242;10005.19958403326;10025.59897604095;10211.744706382326;10583.470826458646;3556.3065202285566;3560.092176495003;3622.2212224371888;3633.5821380541047;3717.4052151655605;72981;73233;73235;73665.6316718413;73800;9350.719478415522;9427.262597499071;9483.383580067273;9557.713268601952;9701.51492425376;18348.990805505826;19996.50008749764;21223;21299.254526091514;21307.254246101624;7039.436845052486;7239.638018099074;7282.089738782653;7283.927160728431;7330.303621155982;3888.650021498079;3903.1608204236227;3904.882853514399;3945.2504024235877;3956.22853543562;3513.156842357867;3563.5367402237544;3564.8930532084078;3565.6612621800887;3577.4276115821863;638.7987783848073;641.6118248459708;646.6411141816337;651.312864927506;652.9216494020748;511.125974583459;550.3780727777586;578.774278031568;588.5409380683074;595.0152497616451;7862;7908.881366779503;8049.235322644457;8137.89798424536;8326.583670816555;495.3362494257712;495.970241785494;524.6484855147061;563.6702529020569;578.9594728368974;3680.0615842959874;3726.6646001859963;3755.136318646672;3810.561785394715;3828.291766023239;86143;86706.56646716852;91445;93036;93593;59407;72682.63658681778;73346.8997965031;74725.6263718678;75581;66135;66214.66892665603;67520.3247967524;67742;68806;7440;7508.849823003618;7517.812054698677;7688.461807673633;7949.880751788844;34248.48627270543;48854.534363969135;49353.50646493489;49904;50061;64152;67357.3264267351;68260.6586967062;68519;68878.65560672164;10780.622678206226;10862.565497380016;10918.78162436731;11027.669169924915;11145.49845256949;11931.46308416106;11979.101567382308;11981.820272696092;12041.157119001586;12097.637070887535;9565;11408.600698975495;11477.081833453136;11852.644420667393;11902.642920712393;11122.165837562054;11127.109831213646;11188.216824822184;11285.605003824827;11592.942035289769;10942.726431839268;11016.944915275373;11241.66275011751;11332.150088743541;11358.204925655455;9113.453192808453;9173.77065573366;9414.388064776042;9448.338616296793;9520.952395237979;8815.911840881508;9289.16397524226;9475.810483790423;9662.17871480932;9678.17735492491 10:41:27 INFO - PROCESS | 1678 | __end_tp_report 10:41:27 INFO - PROCESS | 1678 | __start_cc_report 10:41:27 INFO - PROCESS | 1678 | _x_x_mozilla_cycle_collect,1170 10:41:27 INFO - PROCESS | 1678 | __end_cc_report 10:41:27 INFO - PROCESS | 1678 | __startTimestamp1456425687600__endTimestamp 10:41:27 INFO - PROCESS | 1678 | 10:41:27 INFO - PROCESS | 1678 | ------- Summary: start ------- 10:41:27 INFO - PROCESS | 1678 | Number of tests: 6 10:41:27 INFO - PROCESS | 1678 | 10:41:27 INFO - PROCESS | 1678 | [#0] dojo.html Cycles:165 Average:5648.08 Median:5891.47 stddev:621.33 (10.5%) stddev-sans-first:598.16 10:41:27 INFO - PROCESS | 1678 | Values: 3420.8 3430.7 3452.3 3473.6 3508.7 5551.6 5585.7 5606.6 5609.8 5635.7 5572.0 5616.2 5637.1 5640.6 5641.3 5095.2 5121.9 5143.0 5156.4 5204.1 5200.2 5202.0 5209.6 5211.0 5216.0 5176.8 5198.9 5205.1 5215.6 5230.4 5160.3 5198.9 5203.6 5213.8 5260.7 5066.8 5072.9 5089.1 5135.5 5145.6 4818.0 5509.6 5509.8 5515.3 5565.1 6128.7 6157.1 6159.2 6159.7 6161.6 6089.9 6105.5 6183.2 6192.4 6200.3 5804.1 5815.0 5817.4 5836.8 5848.3 6213.0 6214.6 6219.0 6223.3 6315.9 5951.7 5982.3 6062.6 6101.0 6107.6 6111.5 6131.1 6143.7 6164.5 6175.4 6098.5 6119.3 6138.8 6145.7 6146.9 6036.2 6115.1 6118.3 6130.0 6134.0 4811.7 4821.6 4827.7 4832.3 4851.0 4326.5 4388.9 4410.3 4418.7 4422.6 5564.6 5602.4 5612.8 5620.1 5620.4 6174.7 6177.1 6186.6 6204.2 6214.0 5499.8 5569.9 5581.7 5593.1 5607.9 5242.8 5257.0 5258.2 5264.9 5283.7 6115.8 6124.0 6166.1 6189.5 6190.1 5162.6 6153.6 6173.6 6185.8 6187.2 6232.0 6239.1 6259.7 6265.8 6269.1 5556.8 5686.2 6036.2 6042.0 6070.1 6140.2 6175.9 6180.6 6186.7 6187.9 6008.5 6057.1 6057.1 6080.7 6091.2 4530.8 5891.5 5999.7 6067.8 6076.6 5897.7 5908.8 5917.8 5944.2 5962.9 5018.5 5987.1 6024.2 6032.4 6041.6 5746.6 5805.9 5914.1 5918.6 5935.3 10:41:27 INFO - PROCESS | 1678 | 10:41:27 INFO - PROCESS | 1678 | [#1] ext.html Cycles:180 Average:62370.61 Median:360176.50 stddev:137142.18 (38.1%) stddev-sans-first:137448.18 10:41:27 INFO - PROCESS | 1678 | Values: 481.4 552.8 556.0 559.7 592.8 29289.6 37544.6 37580.0 37668.2 37794.4 40118.8 40440.0 40614.2 40656.0 40754.4 7873.2 9449.1 9450.1 9457.0 9472.8 9346.9 9483.7 9508.4 9515.1 9518.5 9554.3 9654.3 9662.0 9674.5 9729.3 9583.1 9610.1 9611.1 9631.3 9677.1 9408.2 9563.9 9565.8 9567.8 9583.1 38918.0 39313.8 39329.8 39366.0 39379.0 3148.5 3224.6 3291.0 3476.9 3681.1 27668.0 27934.6 28098.7 28566.9 28698.9 2705.9 2745.7 2747.2 2793.8 2837.7 484733.0 486438.0 488731.0 488741.0 488803.0 35421.0 44615.0 59852.4 60242.0 60349.1 43189.1 43270.4 43453.1 43468.6 43502.0 14925.9 15112.8 15119.3 15126.8 15149.0 12141.6 12226.9 12232.9 12236.7 12254.5 12088.7 14251.6 14277.0 14307.9 14387.5 6228.9 6317.9 6357.2 6359.1 6376.0 906.8 984.0 1017.8 1054.9 1131.5 23913.4 28692.9 29400.7 29484.6 29486.7 859.6 1046.8 1055.6 1073.6 1159.4 15345.8 15433.9 15447.1 15751.5 15823.6 597687.0 653584.0 662521.0 662663.0 663689.0 57992.7 58590.1 58688.0 58816.7 58823.0 1274.1 1303.9 1401.6 1425.3 1553.2 23859.4 26523.7 28350.0 28417.0 28684.9 46022.1 46131.1 46708.8 46743.8 46816.0 356950.0 357050.0 360144.0 360209.0 360760.0 31356.5 31710.7 31739.8 32302.8 32371.0 41644.0 41915.5 42125.4 42878.7 43016.0 31203.2 31712.2 34480.5 35358.0 35524.8 34623.3 34694.0 35136.6 35235.6 35510.8 34285.0 34598.8 34784.5 35038.5 35381.0 24503.0 28403.6 29566.0 30906.2 30921.5 23353.8 23649.8 23790.4 23965.8 24003.8 10:41:27 INFO - PROCESS | 1678 | 10:41:27 INFO - PROCESS | 1678 | [#2] jquery.html Cycles:180 Average:34629.81 Median:27869.15 stddev:93220.80 (334.5%) stddev-sans-first:93446.78 10:41:27 INFO - PROCESS | 1678 | Values: 352.1 353.3 356.2 361.1 362.3 19193.2 19640.0 21338.1 21389.0 21406.8 20235.0 20635.6 20932.5 20950.2 20965.6 5718.5 6037.8 6041.9 6043.2 6073.4 4136.8 5903.0 6265.4 6538.3 6544.8 5476.7 6480.8 6482.2 6482.7 6488.6 5505.4 5676.6 5705.1 5739.7 5750.2 3807.7 6939.8 7227.0 7241.9 7252.9 25826.0 26976.2 27386.5 27810.6 27927.7 2223.6 2322.6 2482.6 2501.5 2989.6 14689.0 14945.9 15163.9 15693.6 15715.1 1806.9 1828.9 1867.0 1924.7 2016.3 115149.4 125282.7 125589.0 125589.4 126465.4 19098.7 19276.8 19501.0 19518.4 19621.4 28796.0 29005.0 29047.4 29059.9 29139.6 10427.3 10693.7 10696.0 10706.6 10825.5 9130.5 9132.4 9134.6 9220.1 9241.6 8625.8 8655.7 8743.4 8763.6 8777.2 2313.0 3333.1 3395.3 3537.1 3581.3 698.8 784.6 822.7 972.5 1035.7 19535.0 20322.8 20400.8 20445.5 20611.0 913.4 938.3 950.2 960.9 968.7 10351.5 10851.1 10985.0 11013.3 11112.7 534874.0 555043.0 556053.0 557614.0 587443.0 118770.8 120801.4 121020.0 121258.4 122457.4 992.8 996.7 1009.7 1011.1 1030.1 17840.6 18127.6 18279.5 18294.3 18642.3 50809.0 51689.7 51737.7 52579.5 53635.5 54782.7 57486.0 71448.6 74695.3 77424.0 7901.8 8030.6 8114.9 8163.3 8427.4 9318.0 12375.7 12793.7 12861.7 13337.5 9498.1 10741.4 11131.3 11657.2 11779.5 10545.3 10814.1 11191.9 11253.4 11564.5 11414.0 11695.9 11705.9 11730.7 11779.2 7970.2 8140.0 8152.1 8209.3 8309.6 10900.0 11361.1 11490.0 11526.8 11753.4 10:41:27 INFO - PROCESS | 1678 | 10:41:27 INFO - PROCESS | 1678 | [#3] mootools.html Cycles:180 Average:5810.90 Median:5711.79 stddev:3041.22 (53.2%) stddev-sans-first:3030.94 10:41:27 INFO - PROCESS | 1678 | Values: 1311.3 1379.5 1529.5 1698.5 1931.1 6935.4 7649.3 8368.3 8375.3 8387.1 8075.7 8327.1 8335.6 8341.2 8341.3 2142.6 2346.6 2401.4 2407.9 2431.2 2422.0 2428.7 2428.9 2429.6 2431.8 2367.2 2374.5 2424.9 2431.4 2431.9 2385.2 2426.4 2430.9 2431.2 2433.1 2397.1 2418.6 2427.8 2429.1 2440.9 8402.1 8496.9 8500.8 8508.7 8509.3 5208.0 5354.0 5359.3 5361.4 5361.9 3519.2 3551.1 3629.5 3688.6 3689.4 1037.5 1047.0 1049.7 1059.6 1062.6 11306.8 11320.4 11323.5 11332.4 11334.1 4682.8 4740.4 4801.1 4814.3 4816.7 9754.0 9791.9 9795.5 9802.2 9808.4 5280.6 5320.6 5321.4 5323.5 5325.8 4285.7 4442.0 4689.5 4738.9 4783.9 3217.3 3764.6 3865.4 3881.2 3918.7 1281.5 1291.4 1294.7 1297.8 1310.3 1285.5 1295.5 1316.3 1329.3 1329.5 7847.7 7909.4 7943.6 7946.7 7949.0 503.1 513.1 515.0 516.6 517.2 6061.7 6103.4 6109.8 6119.0 6121.4 9735.0 9982.8 10067.4 10122.4 10143.1 9604.6 9989.2 10000.3 10002.2 10033.5 7747.2 7919.8 7920.6 7993.3 8013.6 7737.4 7745.8 7829.1 7844.8 7912.4 9049.4 9259.1 9342.5 9374.5 9439.5 9332.6 9581.0 9677.8 9708.5 9742.2 6667.3 6842.6 7075.7 7313.5 7433.8 6704.7 7988.1 8017.4 8021.1 8028.1 6702.5 6841.4 6843.9 6925.0 7009.4 6962.7 6994.4 7060.7 7107.6 7148.6 6357.5 7429.4 7463.5 7532.0 7555.1 6743.7 6754.8 6819.0 6823.0 6836.9 6670.8 6875.6 6885.0 6927.7 6952.0 10:41:27 INFO - PROCESS | 1678 | 10:41:27 INFO - PROCESS | 1678 | [#4] prototype.html Cycles:180 Average:5774.47 Median:6513.67 stddev:1870.14 (28.7%) stddev-sans-first:1829.92 10:41:27 INFO - PROCESS | 1678 | Values: 313.4 321.0 324.9 329.3 332.1 5413.8 6498.8 6551.9 6612.9 6624.8 6389.3 6478.9 6487.3 6512.2 6515.1 4676.1 4747.1 4794.9 4897.5 4906.9 4870.4 4920.6 4941.1 4942.6 4943.9 4646.8 4884.1 4896.1 4900.0 4902.2 4680.6 4775.9 4780.1 4784.3 4798.1 4102.3 4110.1 4119.7 4120.6 4125.5 6246.6 6319.3 6335.5 6353.8 6356.7 5695.1 5720.8 5723.8 5725.1 5732.9 6804.9 7013.5 7032.2 7041.8 7052.2 3853.9 4478.9 4525.4 4530.5 4534.3 7321.5 7397.7 7413.0 7430.6 7450.8 4591.5 4599.7 4600.7 4606.3 4608.1 4661.3 4664.9 4672.3 4678.8 4681.8 5594.5 5596.3 5598.7 5598.9 5602.6 6857.1 7126.4 7138.3 7154.5 7169.2 1587.4 1627.0 1628.6 1628.8 1634.5 834.3 969.8 1004.3 1033.7 1036.8 5904.3 6394.7 6462.4 6588.2 6678.9 5987.0 7429.4 7431.2 7441.9 7465.1 6550.7 6564.8 6571.4 6571.9 6574.8 3890.6 3935.3 3941.6 3943.8 3948.9 7434.1 7661.8 7711.1 7777.0 7792.9 7637.2 7661.0 7684.5 7693.3 7693.8 7730.0 7735.6 7737.3 7739.2 7739.4 7139.0 7428.8 7429.8 7430.9 7444.9 7235.2 7290.9 7297.9 7309.4 7333.4 7720.6 7725.8 7733.3 7745.9 7765.1 4581.2 4642.2 4645.3 4652.8 4658.1 5999.2 7113.8 7302.7 7391.2 7400.4 6053.9 6918.1 7093.8 7155.2 7166.2 5749.4 7126.6 7131.5 7148.0 7150.3 6960.5 6975.0 6995.4 6999.7 7001.3 6837.7 7149.3 7149.4 7168.0 7168.5 6694.1 6795.7 6830.8 7002.1 7009.7 10:41:27 INFO - PROCESS | 1678 | 10:41:27 INFO - PROCESS | 1678 | [#5] yui.html Cycles:180 Average:17515.50 Median:636.50 stddev:24383.83 (3830.9%) stddev-sans-first:24419.28 10:41:27 INFO - PROCESS | 1678 | Values: 634.2 730.2 733.4 751.7 770.1 14612.4 14830.3 14842.3 14848.0 14877.4 13394.1 13407.2 13415.0 13450.3 13638.0 696.7 850.9 866.0 866.5 867.6 700.0 701.1 703.1 703.7 828.1 799.4 900.8 905.4 905.6 906.1 896.4 900.8 901.9 902.2 902.4 542.6 653.2 661.0 667.5 667.8 14649.8 14684.6 14697.2 14713.9 14717.6 10569.6 12206.9 12316.6 12367.1 12646.9 9954.7 10005.2 10025.6 10211.7 10583.5 3556.3 3560.1 3622.2 3633.6 3717.4 72981.0 73233.0 73235.0 73665.6 73800.0 9350.7 9427.3 9483.4 9557.7 9701.5 18349.0 19996.5 21223.0 21299.3 21307.3 7039.4 7239.6 7282.1 7283.9 7330.3 3888.7 3903.2 3904.9 3945.3 3956.2 3513.2 3563.5 3564.9 3565.7 3577.4 638.8 641.6 646.6 651.3 652.9 511.1 550.4 578.8 588.5 595.0 7862.0 7908.9 8049.2 8137.9 8326.6 495.3 496.0 524.6 563.7 579.0 3680.1 3726.7 3755.1 3810.6 3828.3 86143.0 86706.6 91445.0 93036.0 93593.0 59407.0 72682.6 73346.9 74725.6 75581.0 66135.0 66214.7 67520.3 67742.0 68806.0 7440.0 7508.8 7517.8 7688.5 7949.9 34248.5 48854.5 49353.5 49904.0 50061.0 64152.0 67357.3 68260.7 68519.0 68878.7 10780.6 10862.6 10918.8 11027.7 11145.5 11931.5 11979.1 11981.8 12041.2 12097.6 9565.0 11408.6 11477.1 11852.6 11902.6 11122.2 11127.1 11188.2 11285.6 11592.9 10942.7 11016.9 11241.7 11332.2 11358.2 9113.5 9173.8 9414.4 9448.3 9521.0 8815.9 9289.2 9475.8 9662.2 9678.2 10:41:27 INFO - PROCESS | 1678 | -------- Summary: end -------- 10:41:27 INFO - PROCESS | 1678 | 10:41:28 INFO - TEST-INFO | 1678: exit 0 10:41:28 INFO - TEST-OK | dromaeo_css | took 1113844ms 10:41:28 INFO - TEST-START | kraken 10:41:28 INFO - operating with platform_type : mac_ 10:41:28 INFO - Initialising browser for kraken test... 10:41:28 INFO - TEST-INFO | started process 1685 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/tmpk646Bn/profile http://localhost:49274/getInfo.html) 10:41:30 INFO - PROCESS | 1685 | __metrics Screen width/height:1600/1200 10:41:30 INFO - PROCESS | 1685 | colorDepth:24 10:41:30 INFO - PROCESS | 1685 | Browser inner width/height: 1024/689 10:41:30 INFO - PROCESS | 1685 | __metrics 10:41:30 INFO - PROCESS | 1685 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:41:30 INFO - PROCESS | 1685 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:41:30 INFO - TEST-INFO | 1685: exit 0 10:41:30 INFO - Browser initialized. 10:41:30 INFO - Running cycle 1/1 for kraken test... 10:41:30 INFO - TEST-INFO | started process 1687 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/tmpk646Bn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:41:42 INFO - PROCESS | 1687 | RSS: Main: 242855936 10:41:42 INFO - PROCESS | 1687 | 10:41:45 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 10:41:46 INFO - PROCESS | 1687 | RSS: Main: 290455552 10:41:46 INFO - PROCESS | 1687 | 10:41:48 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 10:41:49 INFO - PROCESS | 1687 | RSS: Main: 301273088 10:41:49 INFO - PROCESS | 1687 | 10:41:52 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 10:41:53 INFO - PROCESS | 1687 | RSS: Main: 286044160 10:41:53 INFO - PROCESS | 1687 | 10:41:55 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 10:41:56 INFO - PROCESS | 1687 | RSS: Main: 290136064 10:41:56 INFO - PROCESS | 1687 | 10:41:58 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:41:58 INFO - PROCESS | 1687 | RSS: Main: 289140736 10:41:58 INFO - PROCESS | 1687 | 10:42:01 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 10:42:02 INFO - PROCESS | 1687 | RSS: Main: 289124352 10:42:02 INFO - PROCESS | 1687 | 10:42:05 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 10:42:05 INFO - PROCESS | 1687 | RSS: Main: 290107392 10:42:05 INFO - PROCESS | 1687 | 10:42:08 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 10:42:08 INFO - PROCESS | 1687 | RSS: Main: 289669120 10:42:08 INFO - PROCESS | 1687 | 10:42:10 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:42:11 INFO - PROCESS | 1687 | RSS: Main: 325156864 10:42:11 INFO - PROCESS | 1687 | 10:42:12 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:42:13 INFO - PROCESS | 1687 | RSS: Main: 324399104 10:42:13 INFO - PROCESS | 1687 | 10:42:15 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:42:16 INFO - PROCESS | 1687 | RSS: Main: 332558336 10:42:16 INFO - PROCESS | 1687 | 10:42:18 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:42:19 INFO - PROCESS | 1687 | RSS: Main: 332197888 10:42:19 INFO - PROCESS | 1687 | 10:42:21 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:42:22 INFO - PROCESS | 1687 | RSS: Main: 333189120 10:42:22 INFO - PROCESS | 1687 | 10:42:24 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 10:42:24 INFO - PROCESS | 1687 | RSS: Main: 393416704 10:42:24 INFO - PROCESS | 1687 | 10:42:24 INFO - PROCESS | 1687 | __start_tp_report 10:42:24 INFO - PROCESS | 1687 | _x_x_mozilla_page_load 10:42:24 INFO - PROCESS | 1687 | _x_x_mozilla_page_load_details 10:42:24 INFO - PROCESS | 1687 | |i|pagename|runs| 10:42:24 INFO - PROCESS | 1687 | |0;ai-astar;120;157;157;109;111;110;114;111;111;109 10:42:24 INFO - PROCESS | 1687 | |1;audio-beat-detection;156;131;173;184;143;145;139;122;157;120 10:42:24 INFO - PROCESS | 1687 | |2;audio-dft;186;257;221;184;181;184;180;183;185;182 10:42:24 INFO - PROCESS | 1687 | |3;audio-fft;73;76;87;83;73;82;85;110;79;57 10:42:24 INFO - PROCESS | 1687 | |4;audio-oscillator;95;96;129;79;78;83;113;77;79;114 10:42:24 INFO - PROCESS | 1687 | |5;imaging-gaussian-blur;85;90;86;132;83;93;84;90;85;91 10:42:24 INFO - PROCESS | 1687 | |6;imaging-darkroom;95;93;95;107;150;125;94;93;94;94 10:42:24 INFO - PROCESS | 1687 | |7;imaging-desaturate;87;87;85;87;86;86;85;84;87;86 10:42:24 INFO - PROCESS | 1687 | |8;json-parse-financial;56;56;55;53;56;55;54;65;56;54 10:42:24 INFO - PROCESS | 1687 | |9;json-stringify-tinderbox;62;64;71;75;70;67;65;65;67;67 10:42:24 INFO - PROCESS | 1687 | |10;stanford-crypto-aes;84;83;83;83;83;82;83;83;84;83 10:42:24 INFO - PROCESS | 1687 | |11;stanford-crypto-ccm;119;129;129;124;113;130;124;125;142;123 10:42:24 INFO - PROCESS | 1687 | |12;stanford-crypto-pbkdf2;138;139;138;136;136;124;136;137;138;137 10:42:24 INFO - PROCESS | 1687 | |13;stanford-crypto-sha256-iterative;67;66;66;67;70;81;90;98;67;65 10:42:24 INFO - PROCESS | 1687 | __end_tp_report 10:42:24 INFO - PROCESS | 1687 | __start_cc_report 10:42:24 INFO - PROCESS | 1687 | _x_x_mozilla_cycle_collect,1250 10:42:24 INFO - PROCESS | 1687 | __end_cc_report 10:42:24 INFO - PROCESS | 1687 | __startTimestamp1456425744389__endTimestamp 10:42:24 INFO - PROCESS | 1687 | 10:42:24 INFO - PROCESS | 1687 | ------- Summary: start ------- 10:42:24 INFO - PROCESS | 1687 | Number of tests: 14 10:42:24 INFO - PROCESS | 1687 | 10:42:24 INFO - PROCESS | 1687 | [#0] ai-astar Cycles:10 Average:120.90 Median:112.50 stddev:19.30 (17.2%) stddev-sans-first:20.46 10:42:24 INFO - PROCESS | 1687 | Values: 120.0 157.0 157.0 109.0 111.0 110.0 114.0 111.0 111.0 109.0 10:42:24 INFO - PROCESS | 1687 | 10:42:24 INFO - PROCESS | 1687 | [#1] audio-beat-detection Cycles:10 Average:147.00 Median:150.50 stddev:20.87 (13.9%) stddev-sans-first:21.88 10:42:24 INFO - PROCESS | 1687 | Values: 156.0 131.0 173.0 184.0 143.0 145.0 139.0 122.0 157.0 120.0 10:42:24 INFO - PROCESS | 1687 | 10:42:24 INFO - PROCESS | 1687 | [#2] audio-dft Cycles:10 Average:194.30 Median:184.50 stddev:25.10 (13.6%) stddev-sans-first:26.45 10:42:24 INFO - PROCESS | 1687 | Values: 186.0 257.0 221.0 184.0 181.0 184.0 180.0 183.0 185.0 182.0 10:42:24 INFO - PROCESS | 1687 | 10:42:24 INFO - PROCESS | 1687 | [#3] audio-fft Cycles:10 Average:80.50 Median:80.50 stddev:13.45 (16.7%) stddev-sans-first:13.99 10:42:24 INFO - PROCESS | 1687 | Values: 73.0 76.0 87.0 83.0 73.0 82.0 85.0 110.0 79.0 57.0 10:42:24 INFO - PROCESS | 1687 | 10:42:24 INFO - PROCESS | 1687 | [#4] audio-oscillator Cycles:10 Average:94.30 Median:79.00 stddev:18.58 (23.5%) stddev-sans-first:19.70 10:42:24 INFO - PROCESS | 1687 | Values: 95.0 96.0 129.0 79.0 78.0 83.0 113.0 77.0 79.0 114.0 10:42:24 INFO - PROCESS | 1687 | 10:42:24 INFO - PROCESS | 1687 | [#5] imaging-gaussian-blur Cycles:10 Average:91.90 Median:88.00 stddev:14.49 (16.5%) stddev-sans-first:15.15 10:42:24 INFO - PROCESS | 1687 | Values: 85.0 90.0 86.0 132.0 83.0 93.0 84.0 90.0 85.0 91.0 10:42:24 INFO - PROCESS | 1687 | 10:42:24 INFO - PROCESS | 1687 | [#6] imaging-darkroom Cycles:10 Average:104.00 Median:94.00 stddev:19.06 (20.3%) stddev-sans-first:19.94 10:42:24 INFO - PROCESS | 1687 | Values: 95.0 93.0 95.0 107.0 150.0 125.0 94.0 93.0 94.0 94.0 10:42:24 INFO - PROCESS | 1687 | 10:42:24 INFO - PROCESS | 1687 | [#7] imaging-desaturate Cycles:10 Average:86.00 Median:86.50 stddev:1.05 (1.2%) stddev-sans-first:1.05 10:42:24 INFO - PROCESS | 1687 | Values: 87.0 87.0 85.0 87.0 86.0 86.0 85.0 84.0 87.0 86.0 10:42:24 INFO - PROCESS | 1687 | 10:42:24 INFO - PROCESS | 1687 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.00 stddev:3.33 (6.0%) stddev-sans-first:3.54 10:42:24 INFO - PROCESS | 1687 | Values: 56.0 56.0 55.0 53.0 56.0 55.0 54.0 65.0 56.0 54.0 10:42:24 INFO - PROCESS | 1687 | 10:42:24 INFO - PROCESS | 1687 | [#9] json-stringify-tinderbox Cycles:10 Average:67.30 Median:67.00 stddev:3.80 (5.7%) stddev-sans-first:3.52 10:42:24 INFO - PROCESS | 1687 | Values: 62.0 64.0 71.0 75.0 70.0 67.0 65.0 65.0 67.0 67.0 10:42:24 INFO - PROCESS | 1687 | 10:42:24 INFO - PROCESS | 1687 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:83.00 stddev:0.57 (0.7%) stddev-sans-first:0.50 10:42:24 INFO - PROCESS | 1687 | Values: 84.0 83.0 83.0 83.0 83.0 82.0 83.0 83.0 84.0 83.0 10:42:24 INFO - PROCESS | 1687 | 10:42:24 INFO - PROCESS | 1687 | [#11] stanford-crypto-ccm Cycles:10 Average:125.80 Median:127.00 stddev:7.64 (6.0%) stddev-sans-first:7.70 10:42:24 INFO - PROCESS | 1687 | Values: 119.0 129.0 129.0 124.0 113.0 130.0 124.0 125.0 142.0 123.0 10:42:24 INFO - PROCESS | 1687 | 10:42:24 INFO - PROCESS | 1687 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.90 Median:137.50 stddev:4.31 (3.1%) stddev-sans-first:4.50 10:42:24 INFO - PROCESS | 1687 | Values: 138.0 139.0 138.0 136.0 136.0 124.0 136.0 137.0 138.0 137.0 10:42:24 INFO - PROCESS | 1687 | 10:42:24 INFO - PROCESS | 1687 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.70 Median:68.50 stddev:11.80 (17.2%) stddev-sans-first:12.26 10:42:24 INFO - PROCESS | 1687 | Values: 67.0 66.0 66.0 67.0 70.0 81.0 90.0 98.0 67.0 65.0 10:42:24 INFO - PROCESS | 1687 | -------- Summary: end -------- 10:42:24 INFO - PROCESS | 1687 | 10:42:25 INFO - TEST-INFO | 1687: exit 0 10:42:25 INFO - TEST-OK | kraken | took 56988ms 10:42:25 INFO - SUITE-END | took 1170s 10:42:25 INFO - Completed test suite (00:19:31) 10:42:25 INFO - Working with test: dromaeo_css 10:42:25 INFO - Generating results file: dromaeo_css 10:42:25 INFO - Working with test: kraken 10:42:25 INFO - Generating results file: kraken 10:42:25 INFO - javascript benchmark 10:42:25 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:42:25 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 10:42:25 INFO - process_Request line: dromaeo_css 7473.89 graph.html#tests=[[72,64,59]] 10:42:25 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:42:25 INFO - process_Request line: kraken 1460.70 graph.html#tests=[[232,64,59]] 10:42:25 INFO - RETURN: dromaeo_css: 7473.89 10:42:25 INFO - RETURN: kraken: 1460.70 10:42:25 INFO - javascript benchmark 10:42:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3420.811855347956, 3430.708389786868, 3452.2750222453283, 3473.583170019598, 3508.7193024558037, 5551.639143455683, 5585.720713964306, 5606.579506537011, 5609.775608975636, 5635.6618602883855, 5571.9721401392935, 5616.185653080301, 5637.069883469233, 5640.633358831673, 5641.294838145232, 5095.235714642796, 5121.923171152435, 5142.997115562467, 5156.355455568054, 5204.089284375238, 5200.167973124301, 5201.973990130044, 5209.635325527214, 5210.973945130269, 5216.0, 5176.8446946591475, 5198.896022079556, 5205.115130427817, 5215.608829337796, 5230.398504172012, 5160.277561141444, 5198.92201616976, 5203.635745497817, 5213.791448342062, 5260.736963151827, 5066.771995260222, 5072.873178170538, 5089.134847076006, 5135.512126347991, 5145.588352931794, 4817.951820481785, 5509.586780991442, 5509.834704958857, 5515.310586176728, 5565.1374037024325, 6128.7242074106325, 6157.107219453154, 6159.168512250833, 6159.661218632973, 6161.599496032743, 6089.924588083034, 6105.511559075308, 6183.1961844960315, 6192.442680158762, 6200.286966998808, 5804.071348584206, 5814.97092514539, 5817.447342502455, 5836.824895253149, 5848.3274423441, 6213.03697926822, 6214.627122372672, 6219.036049412348, 6223.315435302113, 6315.873682526324, 5951.702414879239, 5982.312034116046, 6062.575619706578, 6100.969495152496, 6107.603005804697, 6111.505911234519, 6131.110988906584, 6143.723532441051, 6164.4760195383, 6175.413335733098, 6098.480339642134, 6119.296280927661, 6138.846528836815, 6145.723442445101, 6146.8935591593945, 6036.215292012011, 6115.052166914135, 6118.3269840317525, 6130.049842274455, 6134.0, 4811.663183577186, 4821.590164836029, 4827.710337379698, 4832.275158726149, 4851.0055438635, 4326.524082351002, 4388.868333949987, 4410.33844923264, 4418.690691651618, 4422.624076953431, 5564.554835613141, 5602.411746766531, 5612.7754889803955, 5620.1288800236025, 5620.381758006616, 6174.722137503823, 6177.073438984098, 6186.566940314135, 6204.162438070803, 6214.0, 5499.835004949858, 5569.888602227933, 5581.720913954286, 5593.07714227148, 5607.943920560742, 5242.7640756166065, 5257.0274499217, 5258.2112683097075, 5264.92102618461, 5283.709395983258, 6115.818436018264, 6124.045297608125, 6166.105914642351, 6189.50483961282, 6190.102435146879, 5162.612804039637, 6153.630782153085, 6173.629582225081, 6185.783497577563, 6187.226596675416, 6231.9688401557705, 6239.126522286974, 6259.749610015549, 6265.8120256392385, 6269.059641053878, 5556.777728890799, 5686.175504551899, 6036.154938308729, 6042.0, 6070.089486577049, 6140.228185505789, 6175.876482470415, 6180.5673602849165, 6186.721597528212, 6187.938120618736, 6008.489278411209, 6057.091436284592, 6057.091436284592, 6080.72636731357, 6091.177691011657, 4530.796114174936, 5891.469767720926, 5999.700014999145, 6067.787627433018, 6076.605020673642, 5897.734601942837, 5908.793192238251, 5917.822465326047, 5944.227250457413, 5962.880742385041, 5018.473060328759, 5987.101934709828, 6024.156618073561, 6032.366601506778, 6041.607295525777, 5746.626469279484, 5805.8548536286935, 5914.112883067574, 5918.585699001201, 5935.317438494629], "unit": "score", "name": "dojo.html", "value": 5611.075073264971}, {"lowerIsBetter": false, "replicates": [481.40065618305215, 552.8031811128903, 556.0, 559.6921693068813, 592.8054969236986, 29289.56065659017, 37544.62455375445, 37580.0, 37668.246635067284, 37794.43308350373, 40118.79940600293, 40440.0, 40614.18771624566, 40656.0, 40754.38868416976, 7873.212678732139, 9449.102335278138, 9450.102240287162, 9457.0, 9472.763180920463, 9346.859797103049, 9483.66807161746, 9508.429494230368, 9515.143637072662, 9518.524073796318, 9554.331196816225, 9654.324197306192, 9661.95169024154, 9674.516274186262, 9729.270304727139, 9583.089606487372, 9610.135087842058, 9611.134997850157, 9631.3258071935, 9677.080677335642, 9408.247340212767, 9563.856542151872, 9565.760855978657, 9567.760805979837, 9583.137517623447, 38918.0, 39313.803430982945, 39329.80335098335, 39366.015849603704, 39379.0, 3148.464760990637, 3224.6130464344196, 3290.9506357404657, 3476.89569312921, 3681.1349332906743, 27668.031618893445, 27934.580981285297, 28098.719012809815, 28566.857325706947, 28698.856505717336, 2705.878235479408, 2745.7254274572383, 2747.189579074178, 2793.8463384513843, 2837.65948086231, 484733.0, 486437.97467088833, 488731.0, 488741.0, 488803.0, 35420.99999999948, 44615.0, 59852.401475985556, 60242.0, 60349.09476357858, 43189.13621727548, 43270.35094473585, 43453.13093738107, 43468.56531434645, 43502.0, 14925.850741492663, 15112.848871511364, 15119.319630616648, 15126.773098403533, 15149.0, 12141.635750927486, 12226.877731222574, 12232.877671223352, 12236.694082648006, 12254.509819607116, 12088.697782555506, 14251.57245282643, 14277.000609957204, 14307.856921430652, 14387.496437624633, 6228.875422491616, 6317.873642527124, 6357.205349331333, 6359.141515895388, 6375.968120159369, 906.7959709065408, 983.9803203935882, 1017.8167929772712, 1054.947252637365, 1131.4682099413262, 23913.402164946016, 28692.856535717186, 29400.7059929398, 29484.557731634042, 29486.705132948824, 859.6217664227845, 1046.8063408269495, 1055.630529314749, 1073.63496411219, 1159.3623507071077, 15345.846541534665, 15433.922830385776, 15447.0731756095, 15751.527454176394, 15823.604409889615, 597687.0, 653584.0, 662521.0, 662663.0, 663689.0, 57992.71003644955, 58590.121148182814, 58688.0, 58816.70591647014, 58822.99999999914, 1274.0635632809876, 1303.863094375096, 1401.628568429367, 1425.322971588508, 1553.1845780965084, 23859.403514912265, 26523.734762652126, 28350.007749728662, 28417.0, 28684.852605896365, 46022.079558409314, 46131.077378452916, 46708.76645616886, 46743.76628116838, 46816.0, 356950.0, 357050.0, 360144.0, 360209.0, 360760.0, 31356.529652055695, 31710.68289317077, 31739.84130079335, 32302.83848580742, 32371.028869133963, 41644.0, 41915.53295634638, 42125.36811947762, 42878.71363859089, 43016.0, 31203.219919502193, 31712.207194820316, 34480.48279275863, 35358.0, 35524.82237588899, 34623.307533849686, 34693.95918122461, 35136.64863351334, 35235.64764352426, 35510.82244588761, 34285.0, 34598.827005865816, 34784.47823282602, 35038.47442288419, 35381.0, 24503.0, 28403.573946391232, 29565.965191218205, 30906.227344316572, 30921.536176956914, 23353.76646233516, 23649.763502364756, 23790.40523986845, 23965.76034239705, 24003.79981000978], "unit": "score", "name": "ext.html", "value": 18572.72176248236}, {"lowerIsBetter": false, "replicates": [352.0758010223164, 353.2704964248826, 356.2056613751335, 361.0792479178098, 362.3314983854787, 19193.232270709173, 19640.0, 21338.146474141053, 21389.0374933128, 21406.785932140694, 20235.0, 20635.587288254224, 20932.476688082807, 20950.16199352024, 20965.580688386224, 5718.513926316257, 6037.788677396292, 6041.939580604204, 6043.244594425697, 6073.3622969588, 4136.834526618932, 5902.97048514759, 6265.373462653721, 6538.313477084909, 6544.770933017346, 5476.726163691819, 6480.805575832709, 6482.222133344006, 6482.708278127472, 6488.610683359014, 5505.449455054502, 5676.602637815355, 5705.115707065412, 5739.684317362543, 5750.166225897264, 3807.733458657895, 6939.757108501179, 7226.963865180693, 7241.927580724178, 7252.8549429011655, 25826.0, 26976.246543974776, 27386.45227095447, 27810.582841257397, 27927.720722792918, 2223.5775202711434, 2322.5935461294207, 2482.6276058591175, 2501.474690315018, 2989.626296712911, 14689.005738049114, 14945.850541494663, 15163.924180379028, 15693.607659808597, 15715.135667538281, 1806.8554515638718, 1828.9085545722794, 1866.9906650466796, 1924.6728056230475, 2016.2539860251654, 115149.42425287903, 125282.74717252802, 125589.0, 125589.37205314006, 126465.36767316105, 19098.71351929722, 19276.84338939668, 19501.024948752507, 19518.414447566596, 19621.411357659294, 28796.0, 29005.0, 29047.41905161885, 29059.854700726362, 29139.562906556417, 10427.322224055411, 10693.679189624323, 10696.037356637784, 10706.625268115735, 10825.458727063773, 9130.452172869649, 9132.360734748503, 9134.634614615341, 9220.077992200726, 9241.61375793623, 8625.827483450421, 8655.740327790176, 8743.431676940978, 8763.649454021768, 8777.166169213915, 2312.9884350578477, 3333.0500807269814, 3395.303962687643, 3537.133402316449, 3581.301646179022, 698.8218004408944, 784.6429874407131, 822.6956026270318, 972.5234635028785, 1035.6634093919356, 19535.0, 20322.796772032092, 20400.795992040188, 20445.488862778253, 20611.0, 913.3834661603391, 938.3384713776908, 950.1591091883732, 960.8894977077586, 968.6803354892868, 10351.534180961875, 10851.131909447226, 10985.0, 11013.339199648046, 11112.722181945515, 534874.0, 555043.0, 556053.0, 557614.0, 587443.0, 118770.81229187771, 120801.39599302123, 121020.0, 121258.3937080309, 122457.38771306086, 992.8014397120605, 996.6760802739138, 1009.6668099527138, 1011.0698157694939, 1030.1346868630237, 17840.643187135924, 18127.637447250716, 18279.54301142482, 18294.26822927068, 18642.254309827455, 50809.0, 51689.741551292005, 51737.706557336365, 52579.47420525746, 53635.463645363045, 54782.726086369315, 57486.0, 71448.64275678588, 74695.25304746882, 77424.0, 7901.802454938673, 8030.558319292495, 8114.918850811652, 8163.26530612224, 8427.41008129425, 9317.953410232905, 12375.69060773488, 12793.680157996125, 12861.678458038625, 13337.466501339837, 9498.052899155795, 10741.355518668905, 11131.332120072822, 11657.242279251821, 11779.528818847493, 10545.261831671709, 10814.080803131821, 11191.888081119085, 11253.381064041556, 11564.537418503165, 11414.0, 11695.941520292345, 11705.88294117048, 11730.70673233176, 11779.234349767237, 7970.1631328709655, 8140.0, 8152.103268640326, 8209.261166495044, 8309.626066827128, 10900.0, 11361.091112711129, 11490.0, 11526.769464610828, 11753.412329383667], "unit": "score", "name": "jquery.html", "value": 10442.802897625506}, {"lowerIsBetter": false, "replicates": [1311.2853494845308, 1379.4757991963052, 1529.5182017664436, 1698.4904528641405, 1931.053783646013, 6935.375816176543, 7649.349805266552, 8368.330533557317, 8375.329973602113, 8387.077421483631, 8075.676972921076, 8327.125651806564, 8335.58322083895, 8341.165883411655, 8341.33269338453, 2142.5714857028656, 2346.577616029114, 2401.3636386357584, 2407.8555286682767, 2431.2463136427677, 2422.0, 2428.6842710447618, 2428.9028438862424, 2429.647701083342, 2431.7932975697086, 2367.1951536477595, 2374.5250949810106, 2424.87875606219, 2431.404305945046, 2431.8662473563945, 2385.200957679171, 2426.4176597616533, 2430.902763889442, 2431.234161239213, 2433.063270640816, 2397.0771253067696, 2418.6492958520917, 2427.7693619106335, 2429.149797570854, 2440.9145679901117, 8402.075771665111, 8496.915030849674, 8500.829983400297, 8508.74473765788, 8509.276711479532, 5207.958408318314, 5353.973230133864, 5359.276497672803, 5361.437049109826, 5361.892762144775, 3519.2433626770367, 3551.1122219445137, 3629.5281613390353, 3688.5942546319884, 3689.409694448902, 1037.5175543372293, 1046.9685909422728, 1049.7060822969581, 1059.5973530058604, 1062.5696592879897, 11306.830397544043, 11320.377379244139, 11323.490442930006, 11332.43337833105, 11334.149938754545, 4682.789274482657, 4740.3837501124635, 4801.087793319258, 4814.253790662453, 4816.735079570587, 9754.02459754033, 9791.853122203172, 9795.510224488748, 9802.166815820592, 9808.362456440309, 5280.603954703336, 5320.627556071038, 5321.36143662763, 5323.520883120537, 5325.813596524181, 4285.721428107163, 4442.0, 4689.50760170184, 4738.881527961759, 4783.904321913612, 3217.2761128745847, 3764.6047165047275, 3865.381538953754, 3881.243157584244, 3918.7060970427333, 1281.4745954158936, 1291.3930452687223, 1294.6504443800309, 1297.8247936528637, 1310.331730817271, 1285.5436320106414, 1295.4623831109984, 1316.2760481735008, 1329.2622594460167, 1329.5147271245926, 7847.686092556348, 7909.446338756347, 7943.563104029218, 7946.682132714626, 7948.960255198803, 503.0643004012534, 513.1404896797849, 514.9639525233273, 516.5712458659303, 517.1880148167342, 6061.696915154224, 6103.389661033861, 6109.84725381869, 6119.0, 6121.418465245794, 9734.951325243328, 9982.800343993225, 10067.395956242503, 10122.443265620313, 10143.137833284105, 9604.567794449267, 9989.200863930868, 10000.349977251455, 10002.249831262685, 10033.548490317953, 7747.225277472207, 7919.762407127795, 7920.564368959763, 7993.320567751806, 8013.559254241072, 7737.381009519112, 7745.7676269712, 7829.138794732688, 7844.84310313802, 7912.406569507195, 9049.366544341832, 9259.074092590687, 9342.486163261086, 9374.484403357881, 9439.528023598656, 9332.626694932398, 9581.0, 9677.806443870943, 9708.5145742714, 9742.171915386987, 6667.266600674019, 6842.589444633338, 7075.71697132109, 7313.524620899624, 7433.8141546461775, 6704.698288577123, 7988.121306656147, 8017.398695097774, 8021.077576078826, 8028.07677117139, 6702.530822842355, 6841.350071743176, 6843.863122737617, 6925.030495730501, 7009.404200642798, 6962.7214911405, 6994.440444764508, 7060.71757129709, 7107.573545587281, 7148.606826624586, 6357.523185761179, 7429.368503677248, 7463.477556570988, 7531.962340188264, 7555.09338879338, 6743.7302507901095, 6754.831129221809, 6818.965905170442, 6823.0, 6836.897446538405, 6670.764064818778, 6875.5530890491955, 6885.036094946811, 6927.6882540286815, 6951.991961165704], "unit": "score", "name": "mootools.html", "value": 4688.043758938639}, {"lowerIsBetter": false, "replicates": [313.373253493014, 321.04169055369715, 324.94963280691496, 329.3215975091312, 332.14472732713267, 5413.808962028347, 6498.805035848926, 6551.901721474176, 6612.875811112104, 6624.807534643762, 6389.297177310492, 6478.935210647892, 6487.253965793935, 6512.218533775954, 6515.120458738069, 4676.111538807624, 4747.145513807513, 4794.856154315376, 4897.534734200245, 4906.877328066791, 4870.391201099863, 4920.60635149189, 4941.085899108659, 4942.6293028022865, 4943.901121977558, 4646.790894409743, 4884.096442158194, 4896.069746748124, 4899.975500122512, 4902.240152776308, 4680.648951328647, 4775.928361074587, 4780.139574876521, 4784.306275590037, 4798.1123492154065, 4102.323116685743, 4110.095778928631, 4119.711620186588, 4120.587941205856, 4125.50493940729, 6246.562740608159, 6319.336469670664, 6335.461485773715, 6353.841153971188, 6356.682165891733, 5695.088785794294, 5720.771169153229, 5723.771049158028, 5725.141228815669, 5732.942670573282, 6804.863902721918, 7013.544119632207, 7032.156141263081, 7041.753538626123, 7052.153741550996, 3853.9229215415535, 4478.865634030984, 4525.366448697185, 4530.524294949016, 4534.31985202219, 7321.487495875291, 7397.70409183632, 7412.962185294063, 7430.6284685765495, 7450.776476705708, 4591.517890621503, 4599.655025873073, 4600.723956562617, 4606.309053641913, 4608.055348653518, 4661.298626001553, 4664.930026049544, 4672.275797251364, 4678.836240731558, 4681.81272749093, 5594.468525490072, 5596.3284405870745, 5598.720063996784, 5598.916016259759, 5602.551795856321, 6857.108575885203, 7126.394256488256, 7138.321859423347, 7154.4634152438775, 7169.24722904098, 1587.396789220089, 1626.951191464258, 1628.6335574495645, 1628.8452597003266, 1634.5014770495113, 834.3241974001079, 969.7963427680126, 1004.3070281505884, 1033.720895358264, 1036.7770929250248, 5904.3210030847, 6394.712237949303, 6462.38607332312, 6588.209414870246, 6678.9332106679285, 5987.0, 7429.36850367714, 7431.182569917305, 7441.85116297671, 7465.141508726566, 6550.70521826519, 6564.80305590833, 6571.408573228432, 6571.868562628721, 6574.76988305407, 3890.6498415142773, 3935.2719746846924, 3941.6452519273403, 3943.7830919299713, 3948.9210215795524, 7434.145073316529, 7661.808454788675, 7711.113221979432, 7777.0, 7792.922070779219, 7637.15991240963, 7660.961695191489, 7684.46208765381, 7693.346065584376, 7693.846123077507, 7729.961350193325, 7735.574543400167, 7737.342325902361, 7739.1873853245725, 7739.419543534144, 7139.0, 7428.777136685908, 7429.8142546436775, 7430.888536672062, 7444.925550744423, 7235.204127546071, 7290.854182916418, 7297.890531641923, 7309.415246780139, 7333.413326933725, 7720.575368354795, 7725.845483090419, 7733.265339792711, 7745.922540774745, 7765.107012693613, 4581.1753884299815, 4642.2340313847835, 4645.279981602857, 4652.837150699709, 4658.068386322817, 5999.1901093351835, 7113.75101871432, 7302.671379788028, 7391.2239214881665, 7400.444966627417, 6053.878922421615, 6918.135233095863, 7093.82265443368, 7155.212926578176, 7166.175889772534, 5749.367569567428, 7126.643667816692, 7131.465140114616, 7148.0350152728715, 7150.320719531636, 6960.512764106464, 6975.0, 6995.440364770908, 6999.650017499206, 7001.334873187039, 6837.658117094026, 7149.319909821292, 7149.392301654418, 7168.0, 7168.498205125591, 6694.096296999843, 6795.694193761392, 6830.7609233676585, 7002.089728335284, 7009.684564194521], "unit": "score", "name": "prototype.html", "value": 5139.0977811931925}, {"lowerIsBetter": false, "replicates": [634.1977398590782, 730.247844719938, 733.4205977277949, 751.7105914223023, 770.1489853711652, 14612.415503379865, 14830.332635031422, 14842.33209505572, 14848.0, 14877.404903803836, 13394.12938159019, 13407.19556826591, 13415.0, 13450.327483625828, 13637.977151713612, 696.7178292791427, 850.9276711479516, 866.0213958227195, 866.4757821517954, 867.5618812499711, 699.9545029573087, 701.1200942816757, 703.0543918429704, 703.7255470366562, 828.056016141599, 799.3645052183499, 900.7973206028624, 905.4024343933006, 905.5924833824772, 906.1029580715077, 896.4173287363201, 900.7567956651733, 901.9188273055423, 902.2421166220373, 902.41794042842, 542.5578153804637, 653.2455014458309, 660.9919872194893, 667.4927055437854, 667.8363800868818, 14649.780253296209, 14684.559463216014, 14697.191654459, 14713.852861471356, 14717.632059198499, 10569.577216911315, 12206.877931220663, 12316.568920087844, 12367.134300598962, 12646.873531264662, 9954.701358959242, 10005.19958403326, 10025.59897604095, 10211.744706382326, 10583.470826458646, 3556.3065202285566, 3560.092176495003, 3622.2212224371888, 3633.5821380541047, 3717.4052151655605, 72981.0, 73233.0, 73235.0, 73665.6316718413, 73800.0, 9350.719478415522, 9427.262597499071, 9483.383580067273, 9557.713268601952, 9701.51492425376, 18348.990805505826, 19996.50008749764, 21223.0, 21299.254526091514, 21307.254246101624, 7039.436845052486, 7239.638018099074, 7282.089738782653, 7283.927160728431, 7330.303621155982, 3888.650021498079, 3903.1608204236227, 3904.882853514399, 3945.2504024235877, 3956.22853543562, 3513.156842357867, 3563.5367402237544, 3564.8930532084078, 3565.6612621800887, 3577.4276115821863, 638.7987783848073, 641.6118248459708, 646.6411141816337, 651.312864927506, 652.9216494020748, 511.125974583459, 550.3780727777586, 578.774278031568, 588.5409380683074, 595.0152497616451, 7862.0, 7908.881366779503, 8049.235322644457, 8137.89798424536, 8326.583670816555, 495.3362494257712, 495.970241785494, 524.6484855147061, 563.6702529020569, 578.9594728368974, 3680.0615842959874, 3726.6646001859963, 3755.136318646672, 3810.561785394715, 3828.291766023239, 86143.0, 86706.56646716852, 91445.0, 93036.0, 93593.0, 59407.0, 72682.63658681778, 73346.8997965031, 74725.6263718678, 75581.0, 66135.0, 66214.66892665603, 67520.3247967524, 67742.0, 68806.0, 7440.0, 7508.849823003618, 7517.812054698677, 7688.461807673633, 7949.880751788844, 34248.48627270543, 48854.534363969135, 49353.50646493489, 49904.0, 50061.0, 64152.0, 67357.3264267351, 68260.6586967062, 68519.0, 68878.65560672164, 10780.622678206226, 10862.565497380016, 10918.78162436731, 11027.669169924915, 11145.49845256949, 11931.46308416106, 11979.101567382308, 11981.820272696092, 12041.157119001586, 12097.637070887535, 9565.0, 11408.600698975495, 11477.081833453136, 11852.644420667393, 11902.642920712393, 11122.165837562054, 11127.109831213646, 11188.216824822184, 11285.605003824827, 11592.942035289769, 10942.726431839268, 11016.944915275373, 11241.66275011751, 11332.150088743541, 11358.204925655455, 9113.453192808453, 9173.77065573366, 9414.388064776042, 9448.338616296793, 9520.952395237979, 8815.911840881508, 9289.16397524226, 9475.810483790423, 9662.17871480932, 9678.17735492491], "unit": "score", "name": "yui.html", "value": 6647.035879856082}], "name": "dromaeo_css", "value": 7473.893613097927}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [120.0, 157.0, 157.0, 109.0, 111.0, 110.0, 114.0, 111.0, 111.0, 109.0], "unit": "score", "name": "ai-astar", "value": 120.9}, {"lowerIsBetter": true, "replicates": [156.0, 131.0, 173.0, 184.0, 143.0, 145.0, 139.0, 122.0, 157.0, 120.0], "unit": "score", "name": "audio-beat-detection", "value": 147.0}, {"lowerIsBetter": true, "replicates": [186.0, 257.0, 221.0, 184.0, 181.0, 184.0, 180.0, 183.0, 185.0, 182.0], "unit": "score", "name": "audio-dft", "value": 194.3}, {"lowerIsBetter": true, "replicates": [73.0, 76.0, 87.0, 83.0, 73.0, 82.0, 85.0, 110.0, 79.0, 57.0], "unit": "score", "name": "audio-fft", "value": 80.5}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 129.0, 79.0, 78.0, 83.0, 113.0, 77.0, 79.0, 114.0], "unit": "score", "name": "audio-oscillator", "value": 94.3}, {"lowerIsBetter": true, "replicates": [85.0, 90.0, 86.0, 132.0, 83.0, 93.0, 84.0, 90.0, 85.0, 91.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 91.9}, {"lowerIsBetter": true, "replicates": [95.0, 93.0, 95.0, 107.0, 150.0, 125.0, 94.0, 93.0, 94.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 104.0}, {"lowerIsBetter": true, "replicates": [87.0, 87.0, 85.0, 87.0, 86.0, 86.0, 85.0, 84.0, 87.0, 86.0], "unit": "score", "name": "imaging-desaturate", "value": 86.0}, {"lowerIsBetter": true, "replicates": [56.0, 56.0, 55.0, 53.0, 56.0, 55.0, 54.0, 65.0, 56.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.0}, {"lowerIsBetter": true, "replicates": [62.0, 64.0, 71.0, 75.0, 70.0, 67.0, 65.0, 65.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.3}, {"lowerIsBetter": true, "replicates": [84.0, 83.0, 83.0, 83.0, 83.0, 82.0, 83.0, 83.0, 84.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.1}, {"lowerIsBetter": true, "replicates": [119.0, 129.0, 129.0, 124.0, 113.0, 130.0, 124.0, 125.0, 142.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.8}, {"lowerIsBetter": true, "replicates": [138.0, 139.0, 138.0, 136.0, 136.0, 124.0, 136.0, 137.0, 138.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 135.9}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 66.0, 67.0, 70.0, 81.0, 90.0, 98.0, 67.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 73.7}], "name": "kraken", "value": 1460.7}]} 10:42:25 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1460.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7473.89"}}} 10:42:25 INFO - Return code: 0 10:42:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:42:25 INFO - # TBPL SUCCESS # 10:42:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:42:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:42:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:42:25 INFO - 2016-02-25 10:42:25.790 screenresolution[1691:9622] starting screenresolution argv=screenresolution get 10:42:25 INFO - 2016-02-25 10:42:25.793 screenresolution[1691:9622] Display 0: 1600x1200x32@60 10:42:25 INFO - 2016-02-25 10:42:25.799 screenresolution[1692:9625] starting screenresolution argv=screenresolution list 10:42:25 INFO - Available Modes on Display 0 10:42:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:42:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:42:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:42:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:42:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:42:26 INFO - Intel Iris: 10:42:26 INFO - Chipset Model: Intel Iris 10:42:26 INFO - Type: GPU 10:42:26 INFO - Bus: Built-In 10:42:26 INFO - VRAM (Dynamic, Max): 1536 MB 10:42:26 INFO - Vendor: Intel (0x8086) 10:42:26 INFO - Device ID: 0x0a2e 10:42:26 INFO - Revision ID: 0x0009 10:42:26 INFO - Displays: 10:42:26 INFO - Display: 10:42:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:42:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:42:26 INFO - Display Serial Number: 1600x1200 60 10:42:26 INFO - Main Display: Yes 10:42:26 INFO - Mirror: Off 10:42:26 INFO - Online: Yes 10:42:26 INFO - Rotation: Supported 10:42:26 INFO - Return code: 0 10:42:26 INFO - Running post-action listener: _resource_record_post_action 10:42:26 INFO - Running post-run listener: _resource_record_post_run 10:42:27 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 38958592; Write bytes: 707339264; Read time: 429; Write time: 1884 10:42:27 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 402946560; Write bytes: 392889856; Read time: 29791; Write time: 741 10:42:27 INFO - run-tests - Wall time: 1174s; CPU: 52.0%; Read bytes: 31833600; Write bytes: 298679808; Read time: 336; Write time: 1103 10:42:27 INFO - Running post-run listener: _upload_blobber_files 10:42:27 INFO - Blob upload gear active. 10:42:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:42:27 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 10:42:27 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'] 10:42:27 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 10:42:27 INFO - (blobuploader) - INFO - Open directory for files ... 10:42:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:42:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:42:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:42:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:42:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:42:28 INFO - (blobuploader) - INFO - Done attempting. 10:42:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:42:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:42:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:42:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:42:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:42:29 INFO - (blobuploader) - INFO - Done attempting. 10:42:29 INFO - (blobuploader) - INFO - Iteration through files over. 10:42:29 INFO - Return code: 0 10:42:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:42:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:42:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0308bcfb5a14c96f752313d8cf689f8a011a4f903f013cb36393536dc38c8bcbb1602e753acfc77699963c71a67d7254c67e939672a5159ed9b54d081170b7f8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5c935ab464b172d875f86fa2c85a3264fe4fa92ec57dae082dfe84713bcb54cf845c1227f5f86588fba106c4e596c5b319a3f1bd1a44310b83b65c4b8cb67424"} 10:42:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:42:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:42:29 INFO - Contents: 10:42:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0308bcfb5a14c96f752313d8cf689f8a011a4f903f013cb36393536dc38c8bcbb1602e753acfc77699963c71a67d7254c67e939672a5159ed9b54d081170b7f8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5c935ab464b172d875f86fa2c85a3264fe4fa92ec57dae082dfe84713bcb54cf845c1227f5f86588fba106c4e596c5b319a3f1bd1a44310b83b65c4b8cb67424"} 10:42:29 INFO - Running post-run listener: copy_logs_to_upload_dir 10:42:29 INFO - Copying logs to upload dir... 10:42:29 INFO - mkdir: /builds/slave/test/build/upload/logs 10:42:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.557744 ========= master_lag: 2.83 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-02-25 10:42:32.360890) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-25 10:42:32.364440) ========= 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.gGerKSmtfc/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.JMAsRxe77i/Listeners TMPDIR=/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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/0308bcfb5a14c96f752313d8cf689f8a011a4f903f013cb36393536dc38c8bcbb1602e753acfc77699963c71a67d7254c67e939672a5159ed9b54d081170b7f8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5c935ab464b172d875f86fa2c85a3264fe4fa92ec57dae082dfe84713bcb54cf845c1227f5f86588fba106c4e596c5b319a3f1bd1a44310b83b65c4b8cb67424"} build_url:https://queue.taskcluster.net/v1/task/PwXC--t0Roa5fCt94ik59w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011044 build_url: 'https://queue.taskcluster.net/v1/task/PwXC--t0Roa5fCt94ik59w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0308bcfb5a14c96f752313d8cf689f8a011a4f903f013cb36393536dc38c8bcbb1602e753acfc77699963c71a67d7254c67e939672a5159ed9b54d081170b7f8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5c935ab464b172d875f86fa2c85a3264fe4fa92ec57dae082dfe84713bcb54cf845c1227f5f86588fba106c4e596c5b319a3f1bd1a44310b83b65c4b8cb67424"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-25 10:42:32.399681) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 10:42:32.400004) ========= 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.gGerKSmtfc/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.JMAsRxe77i/Listeners TMPDIR=/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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.005196 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 10:42:32.448653) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-25 10:42:32.448965) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-25 10:42:32.449354) ========= ========= Total master_lag: 3.05 =========