builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0019 starttime: 1456274350.21 results: success (0) buildid: 20160223153946 builduid: ed6e5193b1bd4703a77ed477c0393bfe revision: dca97b7dfd1f46bacc098f21315640231f93ef68 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-23 16:39:10.212798) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-23 16:39:10.213328) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-23 16:39:10.213671) ========= 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.2XIKlUP7ec/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.WcVVfVnPUq/Listeners TMPDIR=/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005735 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-23 16:39:10.250355) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-23 16:39:10.250664) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-23 16:39:10.269708) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 16:39:10.270188) ========= 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.2XIKlUP7ec/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.WcVVfVnPUq/Listeners TMPDIR=/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005684 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 16:39:10.319947) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-23 16:39:10.320344) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-23 16:39:10.320978) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 16:39:10.321564) ========= 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.2XIKlUP7ec/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.WcVVfVnPUq/Listeners TMPDIR=/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-02-23 16:39:10-- 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% 15.1M=0.001s 2016-02-23 16:39:10 (15.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113254 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 16:39:10.452731) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 16:39:10.453471) ========= 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.2XIKlUP7ec/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.WcVVfVnPUq/Listeners TMPDIR=/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.027284 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 16:39:10.502983) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-23 16:39:10.503382) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev dca97b7dfd1f46bacc098f21315640231f93ef68 --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 dca97b7dfd1f46bacc098f21315640231f93ef68 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2XIKlUP7ec/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.WcVVfVnPUq/Listeners TMPDIR=/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-02-23 16:39:10,576 truncating revision to first 12 chars 2016-02-23 16:39:10,576 Setting DEBUG logging. 2016-02-23 16:39:10,576 attempt 1/10 2016-02-23 16:39:10,576 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/dca97b7dfd1f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-23 16:39:11,600 unpacking tar archive at: fx-team-dca97b7dfd1f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.272149 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-23 16:39:11.796733) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-23 16:39:11.797201) ========= echo dca97b7dfd1f46bacc098f21315640231f93ef68 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'dca97b7dfd1f46bacc098f21315640231f93ef68'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2XIKlUP7ec/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.WcVVfVnPUq/Listeners TMPDIR=/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False dca97b7dfd1f46bacc098f21315640231f93ef68 program finished with exit code 0 elapsedTime=0.005520 script_repo_revision: 'dca97b7dfd1f46bacc098f21315640231f93ef68' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-23 16:39:11.854948) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-23 16:39:11.858362) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-23 16:39:11.874873) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-02-23 16:39:11.875263) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2XIKlUP7ec/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.WcVVfVnPUq/Listeners TMPDIR=/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 16:39:12 INFO - MultiFileLogger online at 20160223 16:39:12 in /builds/slave/test 16:39:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 16:39:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:39:12 INFO - {'append_to_log': False, 16:39:12 INFO - 'base_work_dir': '/builds/slave/test', 16:39:12 INFO - 'blob_upload_branch': 'Fx-Team', 16:39:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:39:12 INFO - 'branch': 'Fx-Team', 16:39:12 INFO - 'buildbot_json_path': 'buildprops.json', 16:39:12 INFO - 'config_files': ('talos/mac_config.py',), 16:39:12 INFO - 'default_actions': ('clobber', 16:39:12 INFO - 'read-buildbot-config', 16:39:12 INFO - 'download-and-extract', 16:39:12 INFO - 'populate-webroot', 16:39:12 INFO - 'create-virtualenv', 16:39:12 INFO - 'install', 16:39:12 INFO - 'run-tests'), 16:39:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:39:12 INFO - 'download_minidump_stackwalk': True, 16:39:12 INFO - 'download_symbols': 'ondemand', 16:39:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:39:12 INFO - 'tooltool.py': '/tools/tooltool.py', 16:39:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:39:12 INFO - '/tools/misc-python/virtualenv.py')}, 16:39:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:39:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:39:12 INFO - 'installer_path': 'installer.exe', 16:39:12 INFO - 'log_level': 'info', 16:39:12 INFO - 'log_name': 'talos', 16:39:12 INFO - 'log_to_console': True, 16:39:12 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:39:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:39:12 INFO - 'opt_config_files': (), 16:39:12 INFO - 'pip_index': False, 16:39:12 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:39:12 INFO - 'cmd': ('bash', 16:39:12 INFO - '-c', 16:39:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:39:12 INFO - 'enabled': True, 16:39:12 INFO - 'halt_on_failure': False, 16:39:12 INFO - 'name': 'check_screen_resolution'},), 16:39:12 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:39:12 INFO - 'cmd': ('bash', 16:39:12 INFO - '-c', 16:39:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:39:12 INFO - 'enabled': True, 16:39:12 INFO - 'halt_on_failure': False, 16:39:12 INFO - 'name': 'check_screen_resolution'},), 16:39:12 INFO - 'run_cmd_checks_enabled': True, 16:39:12 INFO - 'sps_profile': False, 16:39:12 INFO - 'sps_profile_interval': 0, 16:39:12 INFO - 'suite': 'dromaeojs-e10s', 16:39:12 INFO - 'system_bits': '32', 16:39:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:39:12 INFO - 'title': 't-yosemite-r7-0019', 16:39:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:39:12 INFO - 'use_talos_json': True, 16:39:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:39:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:39:12 INFO - 'work_dir': 'build'} 16:39:12 INFO - ##### 16:39:12 INFO - ##### Running clobber step. 16:39:12 INFO - ##### 16:39:12 INFO - Running pre-action listener: _resource_record_pre_action 16:39:12 INFO - Running main action method: clobber 16:39:12 INFO - rmtree: /builds/slave/test/build 16:39:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:39:13 INFO - Running post-action listener: _resource_record_post_action 16:39:13 INFO - ##### 16:39:13 INFO - ##### Running read-buildbot-config step. 16:39:13 INFO - ##### 16:39:13 INFO - Running pre-action listener: _resource_record_pre_action 16:39:13 INFO - Running main action method: read_buildbot_config 16:39:13 INFO - Using buildbot properties: 16:39:13 INFO - { 16:39:13 INFO - "project": "", 16:39:13 INFO - "product": "firefox", 16:39:13 INFO - "script_repo_revision": "production", 16:39:13 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 16:39:13 INFO - "repository": "", 16:39:13 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 16:39:13 INFO - "buildid": "20160223153946", 16:39:13 INFO - "pgo_build": "False", 16:39:13 INFO - "basedir": "/builds/slave/test", 16:39:13 INFO - "buildnumber": 499, 16:39:13 INFO - "slavename": "t-yosemite-r7-0019", 16:39:13 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 16:39:13 INFO - "platform": "yosemite_r7", 16:39:13 INFO - "scheduler": "tests-fx-team-macosx64-talos", 16:39:13 INFO - "branch": "fx-team", 16:39:13 INFO - "repo_path": "integration/fx-team", 16:39:13 INFO - "revision": "dca97b7dfd1f46bacc098f21315640231f93ef68", 16:39:13 INFO - "stage_platform": "macosx64", 16:39:13 INFO - "builduid": "ed6e5193b1bd4703a77ed477c0393bfe", 16:39:13 INFO - "slavebuilddir": "test" 16:39:13 INFO - } 16:39:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/Xou6s2awTtGEdQ3-fH3PpA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 16:39:13 INFO - Running post-action listener: _resource_record_post_action 16:39:13 INFO - ##### 16:39:13 INFO - ##### Running download-and-extract step. 16:39:13 INFO - ##### 16:39:13 INFO - Running pre-action listener: _resource_record_pre_action 16:39:13 INFO - Running main action method: download_and_extract 16:39:13 INFO - mkdir: /builds/slave/test/build/tests 16:39: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')]} 16:39:13 INFO - https://queue.taskcluster.net/v1/task/Xou6s2awTtGEdQ3-fH3PpA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:39:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xou6s2awTtGEdQ3-fH3PpA/artifacts/public/build/test_packages.json 16:39:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xou6s2awTtGEdQ3-fH3PpA/artifacts/public/build/test_packages.json 16:39:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xou6s2awTtGEdQ3-fH3PpA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 16:39:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xou6s2awTtGEdQ3-fH3PpA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 16:39:14 INFO - Downloaded 1277 bytes. 16:39:14 INFO - Reading from file /builds/slave/test/build/test_packages.json 16:39:14 INFO - Using the following test package requirements: 16:39:14 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 16:39:14 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:39:14 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 16:39:14 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:39:14 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 16:39:14 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:39:14 INFO - u'jsshell-mac.zip'], 16:39:14 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:39:14 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 16:39:14 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 16:39:14 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:39:14 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 16:39:14 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:39:14 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 16:39:14 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:39:14 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 16:39:14 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 16:39:14 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:39:14 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 16:39:14 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:39:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:39:14 INFO - https://queue.taskcluster.net/v1/task/Xou6s2awTtGEdQ3-fH3PpA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:39:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xou6s2awTtGEdQ3-fH3PpA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 16:39:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xou6s2awTtGEdQ3-fH3PpA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 16:39:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xou6s2awTtGEdQ3-fH3PpA/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 16:39:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xou6s2awTtGEdQ3-fH3PpA/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 16:39:15 INFO - Downloaded 17826355 bytes. 16:39:15 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'] 16:39:15 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 16:39:18 INFO - Return code: 0 16:39:18 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 16:39:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:39:18 INFO - https://queue.taskcluster.net/v1/task/Xou6s2awTtGEdQ3-fH3PpA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:39:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xou6s2awTtGEdQ3-fH3PpA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 16:39:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xou6s2awTtGEdQ3-fH3PpA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 16:39:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xou6s2awTtGEdQ3-fH3PpA/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 16:39:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xou6s2awTtGEdQ3-fH3PpA/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 16:39:19 INFO - Downloaded 17826355 bytes. 16:39:19 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'] 16:39:19 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 16:39:23 INFO - Return code: 0 16:39:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:39:23 INFO - https://queue.taskcluster.net/v1/task/Xou6s2awTtGEdQ3-fH3PpA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 16:39:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xou6s2awTtGEdQ3-fH3PpA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 16:39:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xou6s2awTtGEdQ3-fH3PpA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 16:39:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xou6s2awTtGEdQ3-fH3PpA/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 16:39:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xou6s2awTtGEdQ3-fH3PpA/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 16:39:25 INFO - Downloaded 10707015 bytes. 16:39:25 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'] 16:39:25 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 16:39:25 INFO - Return code: 0 16:39:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:39:25 INFO - https://queue.taskcluster.net/v1/task/Xou6s2awTtGEdQ3-fH3PpA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 16:39:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xou6s2awTtGEdQ3-fH3PpA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 16:39:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xou6s2awTtGEdQ3-fH3PpA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 16:39:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xou6s2awTtGEdQ3-fH3PpA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 16:39:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xou6s2awTtGEdQ3-fH3PpA/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 16:39:28 INFO - Downloaded 111455835 bytes. 16:39:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Xou6s2awTtGEdQ3-fH3PpA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 16:39:28 INFO - mkdir: /builds/slave/test/properties 16:39:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:39:28 INFO - Writing to file /builds/slave/test/properties/build_url 16:39:28 INFO - Contents: 16:39:28 INFO - build_url:https://queue.taskcluster.net/v1/task/Xou6s2awTtGEdQ3-fH3PpA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 16:39:30 INFO - Running post-action listener: _resource_record_post_action 16:39:30 INFO - Running post-action listener: set_extra_try_arguments 16:39:30 INFO - ##### 16:39:30 INFO - ##### Running populate-webroot step. 16:39:30 INFO - ##### 16:39:30 INFO - Running pre-action listener: _resource_record_pre_action 16:39:30 INFO - Running main action method: populate_webroot 16:39:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:39:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:39:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:39:30 INFO - '--tppagecycles', 16:39:30 INFO - '7'], 16:39:30 INFO - 'tests': ['tsvgm']}}, 16:39:30 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:39:30 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:39:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:39:30 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:39:30 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:39:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:39:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:39:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:39:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:39:30 INFO - 'talos_options': ['--e10s'], 16:39:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:39:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:39:30 INFO - 'tests': ['damp', 'tps']}, 16:39:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:39:30 INFO - 'talos_options': ['--e10s'], 16:39:30 INFO - 'tests': ['damp', 'tps']}, 16:39:30 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:39:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:39:30 INFO - 'other': {'tests': ['a11yr', 16:39:30 INFO - 'ts_paint', 16:39:30 INFO - 'tpaint', 16:39:30 INFO - 'sessionrestore', 16:39:30 INFO - 'sessionrestore_no_auto_restore']}, 16:39:30 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:39:30 INFO - 'tests': ['a11yr', 16:39:30 INFO - 'ts_paint', 16:39:30 INFO - 'tpaint', 16:39:30 INFO - 'sessionrestore', 16:39:30 INFO - 'sessionrestore_no_auto_restore']}, 16:39:30 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:39:30 INFO - 'tests': ['a11yr', 16:39:30 INFO - 'ts_paint', 16:39:30 INFO - 'tpaint', 16:39:30 INFO - 'sessionrestore', 16:39:30 INFO - 'sessionrestore_no_auto_restore']}, 16:39:30 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:39:30 INFO - 'tests': ['a11yr', 16:39:30 INFO - 'ts_paint', 16:39:30 INFO - 'tpaint', 16:39:30 INFO - 'sessionrestore', 16:39:30 INFO - 'sessionrestore_no_auto_restore']}, 16:39:30 INFO - 'other_l64': {'tests': ['a11yr', 16:39:30 INFO - 'ts_paint', 16:39:30 INFO - 'tpaint', 16:39:30 INFO - 'sessionrestore', 16:39:30 INFO - 'sessionrestore_no_auto_restore']}, 16:39:30 INFO - 'other_nol64': {'tests': ['a11yr', 16:39:30 INFO - 'ts_paint', 16:39:30 INFO - 'tpaint', 16:39:30 INFO - 'sessionrestore', 16:39:30 INFO - 'sessionrestore_no_auto_restore']}, 16:39:30 INFO - 'svgr': {'tests': ['tsvgx', 16:39:30 INFO - 'tsvgr_opacity', 16:39:30 INFO - 'tart', 16:39:30 INFO - 'tscrollx', 16:39:30 INFO - 'cart']}, 16:39:30 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:39:30 INFO - 'tests': ['tsvgx', 16:39:30 INFO - 'tsvgr_opacity', 16:39:30 INFO - 'tart', 16:39:30 INFO - 'tscrollx', 16:39:30 INFO - 'cart']}, 16:39:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:39:30 INFO - 'tests': ['tp5o']}, 16:39:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:39:30 INFO - 'talos_options': ['--e10s'], 16:39:30 INFO - 'tests': ['tp5o']}, 16:39:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:39:30 INFO - 'talos_options': ['--xperf_path', 16:39:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:39:30 INFO - 'tests': ['tp5n']}, 16:39:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:39:30 INFO - 'talos_options': ['--e10s', 16:39:30 INFO - '--xperf_path', 16:39:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:39:30 INFO - 'tests': ['tp5n']}}, 16:39:30 INFO - 'talos.zip': {'path': '', 16:39:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:39:30 INFO - Running post-action listener: _resource_record_post_action 16:39:30 INFO - ##### 16:39:30 INFO - ##### Running create-virtualenv step. 16:39:30 INFO - ##### 16:39:30 INFO - Running pre-action listener: _resource_record_pre_action 16:39:30 INFO - Running main action method: create_virtualenv 16:39:30 INFO - Creating virtualenv /builds/slave/test/build/venv 16:39:30 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 16:39:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:39:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:39:30 INFO - Using real prefix '/tools/python27' 16:39:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:39:30 INFO - Installing distribute.............................................................................................................................................................................................done. 16:39:33 INFO - Installing pip.................done. 16:39:33 INFO - Return code: 0 16:39:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:39: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')]} 16:39:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:39:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39: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')]} 16:39:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:39:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:33 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 0x109ad3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ada4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6e0565590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109977d30>, '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 0x10979bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10996eb20>, '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.2XIKlUP7ec/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.WcVVfVnPUq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:39:33 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 16:39:33 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 16:39:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2XIKlUP7ec/Render', 16:39:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:39:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:39:33 INFO - 'HOME': '/Users/cltbld', 16:39:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:39:33 INFO - 'LOGNAME': 'cltbld', 16:39:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:39:33 INFO - 'MOZ_NO_REMOTE': '1', 16:39:33 INFO - 'NO_EM_RESTART': '1', 16:39:33 INFO - 'PAGER': '/bin/cat', 16:39:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:39:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:39:33 INFO - 'PWD': '/builds/slave/test', 16:39:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:39:33 INFO - 'SHELL': '/bin/bash', 16:39:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WcVVfVnPUq/Listeners', 16:39:33 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 16:39:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:39:33 INFO - 'USER': 'cltbld', 16:39:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:39:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:39:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:39:33 INFO - 'XPC_FLAGS': '0x0', 16:39:33 INFO - 'XPC_SERVICE_NAME': '0', 16:39:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:39:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:39:34 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 16:39:34 INFO - Cleaning up... 16:39:34 INFO - Return code: 0 16:39:34 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:39:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:39:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:39:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:39:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:39:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:34 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 0x109ad3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ada4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6e0565590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109977d30>, '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 0x10979bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10996eb20>, '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.2XIKlUP7ec/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.WcVVfVnPUq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:39:34 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 16:39:34 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 16:39:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2XIKlUP7ec/Render', 16:39:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:39:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:39:34 INFO - 'HOME': '/Users/cltbld', 16:39:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:39:34 INFO - 'LOGNAME': 'cltbld', 16:39:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:39:34 INFO - 'MOZ_NO_REMOTE': '1', 16:39:34 INFO - 'NO_EM_RESTART': '1', 16:39:34 INFO - 'PAGER': '/bin/cat', 16:39:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:39:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:39:34 INFO - 'PWD': '/builds/slave/test', 16:39:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:39:34 INFO - 'SHELL': '/bin/bash', 16:39:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WcVVfVnPUq/Listeners', 16:39:34 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 16:39:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:39:34 INFO - 'USER': 'cltbld', 16:39:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:39:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:39:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:39:34 INFO - 'XPC_FLAGS': '0x0', 16:39:34 INFO - 'XPC_SERVICE_NAME': '0', 16:39:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:39:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:39:34 INFO - Downloading/unpacking psutil>=0.7.1 16:39:34 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 16:39:34 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 16:39:34 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 16:39:34 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 16:39:34 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 16:39:34 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 16:39:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:39:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:39:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:39:37 INFO - Installing collected packages: psutil 16:39:37 INFO - Running setup.py install for psutil 16:39:37 INFO - building 'psutil._psutil_osx' extension 16:39:37 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 16:39:37 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 16:39:37 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 16:39:38 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 16:39:38 INFO - building 'psutil._psutil_posix' extension 16:39:38 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 16:39:38 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:39:38 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:39:38 INFO - ^ 16:39:38 INFO - 1 warning generated. 16:39:38 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 16:39:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:39:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:39:38 INFO - Successfully installed psutil 16:39:38 INFO - Cleaning up... 16:39:38 INFO - Return code: 0 16:39:38 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:39:38 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')]} 16:39:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:39:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:38 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')]} 16:39:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:39:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:38 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 0x109ad3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ada4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6e0565590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109977d30>, '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 0x10979bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10996eb20>, '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.2XIKlUP7ec/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.WcVVfVnPUq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:39:38 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 16:39:38 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 16:39:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2XIKlUP7ec/Render', 16:39:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:39:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:39:38 INFO - 'HOME': '/Users/cltbld', 16:39:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:39:38 INFO - 'LOGNAME': 'cltbld', 16:39:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:39:38 INFO - 'MOZ_NO_REMOTE': '1', 16:39:38 INFO - 'NO_EM_RESTART': '1', 16:39:38 INFO - 'PAGER': '/bin/cat', 16:39:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:39:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:39:38 INFO - 'PWD': '/builds/slave/test', 16:39:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:39:38 INFO - 'SHELL': '/bin/bash', 16:39:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WcVVfVnPUq/Listeners', 16:39:38 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 16:39:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:39:38 INFO - 'USER': 'cltbld', 16:39:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:39:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:39:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:39:38 INFO - 'XPC_FLAGS': '0x0', 16:39:38 INFO - 'XPC_SERVICE_NAME': '0', 16:39:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:39:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:39:38 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:39:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:39:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:39:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:39:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:39:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:39:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:39:41 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:39:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:39:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:39:41 INFO - Installing collected packages: mozsystemmonitor 16:39:41 INFO - Running setup.py install for mozsystemmonitor 16:39:41 INFO - Successfully installed mozsystemmonitor 16:39:41 INFO - Cleaning up... 16:39:41 INFO - Return code: 0 16:39:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:39:41 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')]} 16:39:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:39:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:41 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')]} 16:39:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:39:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:41 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 0x109ad3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ada4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6e0565590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109977d30>, '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 0x10979bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10996eb20>, '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.2XIKlUP7ec/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.WcVVfVnPUq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:39:41 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 16:39:41 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 16:39:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2XIKlUP7ec/Render', 16:39:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:39:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:39:41 INFO - 'HOME': '/Users/cltbld', 16:39:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:39:41 INFO - 'LOGNAME': 'cltbld', 16:39:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:39:41 INFO - 'MOZ_NO_REMOTE': '1', 16:39:41 INFO - 'NO_EM_RESTART': '1', 16:39:41 INFO - 'PAGER': '/bin/cat', 16:39:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:39:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:39:41 INFO - 'PWD': '/builds/slave/test', 16:39:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:39:41 INFO - 'SHELL': '/bin/bash', 16:39:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WcVVfVnPUq/Listeners', 16:39:41 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 16:39:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:39:41 INFO - 'USER': 'cltbld', 16:39:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:39:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:39:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:39:41 INFO - 'XPC_FLAGS': '0x0', 16:39:41 INFO - 'XPC_SERVICE_NAME': '0', 16:39:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:39:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:39:41 INFO - Downloading/unpacking blobuploader==1.2.4 16:39:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:39:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:39:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:39:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:39:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:39:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:39:43 INFO - Downloading blobuploader-1.2.4.tar.gz 16:39:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:39:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:39:43 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 16:39:43 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 16:39:43 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 16:39:43 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 16:39:43 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 16:39:43 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 16:39:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:39:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:39:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:39:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:39:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:39:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:39:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:39:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:39:44 INFO - Downloading docopt-0.6.1.tar.gz 16:39:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:39:45 INFO - Installing collected packages: blobuploader, requests, docopt 16:39:45 INFO - Running setup.py install for blobuploader 16:39:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:39:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:39:45 INFO - Running setup.py install for requests 16:39:45 INFO - Running setup.py install for docopt 16:39:45 INFO - Successfully installed blobuploader requests docopt 16:39:45 INFO - Cleaning up... 16:39:45 INFO - Return code: 0 16:39:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:39:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:39:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:39:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:39:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:39:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:45 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 0x109ad3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ada4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6e0565590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109977d30>, '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 0x10979bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10996eb20>, '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.2XIKlUP7ec/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.WcVVfVnPUq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:39:45 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 16:39:45 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 16:39:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2XIKlUP7ec/Render', 16:39:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:39:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:39:46 INFO - 'HOME': '/Users/cltbld', 16:39:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:39:46 INFO - 'LOGNAME': 'cltbld', 16:39:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:39:46 INFO - 'MOZ_NO_REMOTE': '1', 16:39:46 INFO - 'NO_EM_RESTART': '1', 16:39:46 INFO - 'PAGER': '/bin/cat', 16:39:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:39:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:39:46 INFO - 'PWD': '/builds/slave/test', 16:39:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:39:46 INFO - 'SHELL': '/bin/bash', 16:39:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WcVVfVnPUq/Listeners', 16:39:46 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 16:39:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:39:46 INFO - 'USER': 'cltbld', 16:39:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:39:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:39:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:39:46 INFO - 'XPC_FLAGS': '0x0', 16:39:46 INFO - 'XPC_SERVICE_NAME': '0', 16:39:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:39:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:39:46 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-dKpI4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:39:46 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-mTomqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:39:46 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-1T_kwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:39:46 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-_QvOZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:39:46 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-w5gpzo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:39:46 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-P1W9X_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:39:46 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-OS82Oa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:39:46 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-ekVozZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:39:47 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-RQ8Kgf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:39:47 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-OwNOnR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:39:47 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-FgjMO1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:39:47 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-3_URuX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:39:47 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-unVpP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:39:47 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-0xJZVY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:39:47 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-1iR6mL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:39:47 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-UvAGkT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:39:47 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-NVeLpm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:39:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:39:48 INFO - Running setup.py install for manifestparser 16:39:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:39:48 INFO - Running setup.py install for mozcrash 16:39:48 INFO - Running setup.py install for mozdebug 16:39:48 INFO - Running setup.py install for mozdevice 16:39:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:39:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:39:48 INFO - Running setup.py install for mozfile 16:39:48 INFO - Running setup.py install for mozhttpd 16:39:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:39:48 INFO - Running setup.py install for mozinfo 16:39:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:39:49 INFO - Running setup.py install for mozInstall 16:39:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:39:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:39:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:39:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:39:49 INFO - Running setup.py install for mozleak 16:39:49 INFO - Running setup.py install for mozlog 16:39:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:39:49 INFO - Running setup.py install for moznetwork 16:39:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:39:49 INFO - Running setup.py install for mozprocess 16:39:49 INFO - Running setup.py install for mozprofile 16:39:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:39:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:39:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:39:49 INFO - Running setup.py install for mozrunner 16:39:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:39:50 INFO - Running setup.py install for mozscreenshot 16:39:50 INFO - Running setup.py install for moztest 16:39:50 INFO - Running setup.py install for mozversion 16:39:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:39:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:39:50 INFO - Cleaning up... 16:39:50 INFO - Return code: 0 16:39:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:39:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:39:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:39:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:39:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:39:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:50 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 0x109ad3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ada4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6e0565590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109977d30>, '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 0x10979bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10996eb20>, '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.2XIKlUP7ec/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.WcVVfVnPUq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:39:50 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 16:39:50 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 16:39:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2XIKlUP7ec/Render', 16:39:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:39:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:39:50 INFO - 'HOME': '/Users/cltbld', 16:39:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:39:50 INFO - 'LOGNAME': 'cltbld', 16:39:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:39:50 INFO - 'MOZ_NO_REMOTE': '1', 16:39:50 INFO - 'NO_EM_RESTART': '1', 16:39:50 INFO - 'PAGER': '/bin/cat', 16:39:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:39:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:39:50 INFO - 'PWD': '/builds/slave/test', 16:39:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:39:50 INFO - 'SHELL': '/bin/bash', 16:39:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WcVVfVnPUq/Listeners', 16:39:50 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 16:39:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:39:50 INFO - 'USER': 'cltbld', 16:39:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:39:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:39:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:39:50 INFO - 'XPC_FLAGS': '0x0', 16:39:50 INFO - 'XPC_SERVICE_NAME': '0', 16:39:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:39:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:39:50 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-rhqe1H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:39:51 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)) 16:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:39:51 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-5tlV8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:39:51 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)) 16:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:39:51 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-1MirMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:39:51 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)) 16:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:39:51 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-TMenEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:39:51 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)) 16:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:39:51 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-OTM1iM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:39:51 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)) 16:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:39:51 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-P2XgAP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:39:51 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)) 16:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:39:51 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-IvUF8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:39:51 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)) 16:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:39:51 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-8R9D3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:39:51 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)) 16:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:39:51 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-VtZa0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:39:51 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)) 16:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:39:51 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-hcUfL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:39:51 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)) 16:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:39:51 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-J286lB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:39:52 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)) 16:39:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:39:52 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-6Qy5O1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:39:52 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)) 16:39:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:39:52 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-urnW7e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:39:52 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)) 16:39:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:39:52 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-MNh7Gb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:39:52 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)) 16:39:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:39:52 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-xukKi4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:39:52 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)) 16:39:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:39:52 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-F0QiHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:39:52 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)) 16:39:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:39:52 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-evXWS8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:39:52 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)) 16:39:52 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)) 16:39:52 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)) 16:39:52 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)) 16:39:52 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)) 16:39:52 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)) 16:39:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:39:52 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 16:39:52 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 16:39:52 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 16:39:52 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 16:39:52 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 16:39:52 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 16:39:55 INFO - Downloading blessings-1.6.tar.gz 16:39:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:39:55 INFO - Installing collected packages: blessings 16:39:55 INFO - Running setup.py install for blessings 16:39:55 INFO - Successfully installed blessings 16:39:55 INFO - Cleaning up... 16:39:55 INFO - Return code: 0 16:39:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:39:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:39:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:39:55 INFO - Reading from file tmpfile_stdout 16:39:55 INFO - Current package versions: 16:39:55 INFO - blessings == 1.6 16:39:55 INFO - blobuploader == 1.2.4 16:39:55 INFO - docopt == 0.6.1 16:39:55 INFO - manifestparser == 1.1 16:39:55 INFO - mozInstall == 1.12 16:39:55 INFO - mozcrash == 0.16 16:39:55 INFO - mozdebug == 0.1 16:39:55 INFO - mozdevice == 0.48 16:39:55 INFO - mozfile == 1.2 16:39:55 INFO - mozhttpd == 0.7 16:39:55 INFO - mozinfo == 0.9 16:39:55 INFO - mozleak == 0.1 16:39:55 INFO - mozlog == 3.1 16:39:55 INFO - moznetwork == 0.27 16:39:55 INFO - mozprocess == 0.22 16:39:55 INFO - mozprofile == 0.28 16:39:55 INFO - mozrunner == 6.11 16:39:55 INFO - mozscreenshot == 0.1 16:39:55 INFO - mozsystemmonitor == 0.0 16:39:55 INFO - moztest == 0.7 16:39:55 INFO - mozversion == 1.4 16:39:55 INFO - psutil == 3.1.1 16:39:55 INFO - requests == 1.2.3 16:39:55 INFO - wsgiref == 0.1.2 16:39:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:39:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:39:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:39:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:39:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:55 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 0x109ad3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ada4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6e0565590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109977d30>, '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 0x10979bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10996eb20>, '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.2XIKlUP7ec/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.WcVVfVnPUq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:39:55 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 16:39:55 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 16:39:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2XIKlUP7ec/Render', 16:39:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:39:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:39:55 INFO - 'HOME': '/Users/cltbld', 16:39:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:39:55 INFO - 'LOGNAME': 'cltbld', 16:39:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:39:55 INFO - 'MOZ_NO_REMOTE': '1', 16:39:55 INFO - 'NO_EM_RESTART': '1', 16:39:55 INFO - 'PAGER': '/bin/cat', 16:39:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:39:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:39:55 INFO - 'PWD': '/builds/slave/test', 16:39:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:39:55 INFO - 'SHELL': '/bin/bash', 16:39:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WcVVfVnPUq/Listeners', 16:39:55 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 16:39:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:39:55 INFO - 'USER': 'cltbld', 16:39:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:39:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:39:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:39:55 INFO - 'XPC_FLAGS': '0x0', 16:39:55 INFO - 'XPC_SERVICE_NAME': '0', 16:39:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:39:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:39:55 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)) 16:39:55 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)) 16:39:55 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)) 16:39:55 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)) 16:39:55 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)) 16:39:55 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)) 16:39:55 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)) 16:39:55 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)) 16:39:55 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)) 16:39:55 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)) 16:39:55 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)) 16:39:55 INFO - Cleaning up... 16:39:55 INFO - Return code: 0 16:39:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:39:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:39:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:39:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:39:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:55 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 0x109ad3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ada4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6e0565590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109977d30>, '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 0x10979bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10996eb20>, '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.2XIKlUP7ec/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.WcVVfVnPUq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:39:55 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 16:39:55 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 16:39:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2XIKlUP7ec/Render', 16:39:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:39:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:39:55 INFO - 'HOME': '/Users/cltbld', 16:39:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:39:55 INFO - 'LOGNAME': 'cltbld', 16:39:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:39:55 INFO - 'MOZ_NO_REMOTE': '1', 16:39:55 INFO - 'NO_EM_RESTART': '1', 16:39:55 INFO - 'PAGER': '/bin/cat', 16:39:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:39:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:39:55 INFO - 'PWD': '/builds/slave/test', 16:39:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:39:55 INFO - 'SHELL': '/bin/bash', 16:39:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WcVVfVnPUq/Listeners', 16:39:55 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 16:39:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:39:55 INFO - 'USER': 'cltbld', 16:39:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:39:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:39:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:39:55 INFO - 'XPC_FLAGS': '0x0', 16:39:55 INFO - 'XPC_SERVICE_NAME': '0', 16:39:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:39:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:39:56 INFO - Downloading/unpacking jsonschema 16:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:39:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:39:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:39:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:39:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:39:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:39:58 INFO - Downloading/unpacking functools32 (from jsonschema) 16:39:58 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 16:39:58 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 16:39:58 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 16:39:58 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 16:39:58 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 16:39:58 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 16:39:58 INFO - Downloading functools32-3.2.3-2.tar.gz 16:39:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:39:58 INFO - warning: no files found matching '*.txt' 16:39:58 INFO - no previously-included directories found matching 'build' 16:39:58 INFO - no previously-included directories found matching 'dist' 16:39:58 INFO - no previously-included directories found matching '.git*' 16:39:58 INFO - Installing collected packages: jsonschema, functools32 16:39:59 INFO - Running setup.py install for functools32 16:39:59 INFO - warning: no files found matching '*.txt' 16:39:59 INFO - no previously-included directories found matching 'build' 16:39:59 INFO - no previously-included directories found matching 'dist' 16:39:59 INFO - no previously-included directories found matching '.git*' 16:39:59 INFO - Successfully installed jsonschema functools32 16:39:59 INFO - Cleaning up... 16:39:59 INFO - Return code: 0 16:39:59 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:39: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')]} 16:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:39:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39: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')]} 16:39:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:39:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:59 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 0x109ad3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ada4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6e0565590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109977d30>, '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 0x10979bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10996eb20>, '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.2XIKlUP7ec/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.WcVVfVnPUq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:39:59 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 16:39:59 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 16:39:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2XIKlUP7ec/Render', 16:39:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:39:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:39:59 INFO - 'HOME': '/Users/cltbld', 16:39:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:39:59 INFO - 'LOGNAME': 'cltbld', 16:39:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:39:59 INFO - 'MOZ_NO_REMOTE': '1', 16:39:59 INFO - 'NO_EM_RESTART': '1', 16:39:59 INFO - 'PAGER': '/bin/cat', 16:39:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:39:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:39:59 INFO - 'PWD': '/builds/slave/test', 16:39:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:39:59 INFO - 'SHELL': '/bin/bash', 16:39:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WcVVfVnPUq/Listeners', 16:39:59 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 16:39:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:39:59 INFO - 'USER': 'cltbld', 16:39:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:39:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:39:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:39:59 INFO - 'XPC_FLAGS': '0x0', 16:39:59 INFO - 'XPC_SERVICE_NAME': '0', 16:39:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:39:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:39:59 INFO - Downloading/unpacking flake8 16:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:39:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:39:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:39:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:39:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:40:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:40:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:40:01 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 16:40:01 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 16:40:01 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 16:40:01 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 16:40:01 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 16:40:01 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 16:40:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:40:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:40:02 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 16:40:02 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 16:40:02 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 16:40:02 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 16:40:02 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 16:40:02 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 16:40:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:40:02 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 16:40:02 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 16:40:02 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 16:40:02 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 16:40:02 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 16:40:02 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 16:40:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:40:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:40:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:40:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:40:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:40:03 INFO - no previously-included directories found matching 'docs/_build' 16:40:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:40:03 INFO - Running setup.py install for pep8 16:40:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:40:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:40:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:40:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:40:03 INFO - no previously-included directories found matching 'docs/_build' 16:40:03 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:40:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:40:03 INFO - Cleaning up... 16:40:03 INFO - Return code: 0 16:40:03 INFO - Running post-action listener: _resource_record_post_action 16:40:03 INFO - Running post-action listener: _start_resource_monitoring 16:40:03 INFO - Starting resource monitoring. 16:40:03 INFO - ##### 16:40:03 INFO - ##### Running install step. 16:40:03 INFO - ##### 16:40:03 INFO - Running pre-action listener: _resource_record_pre_action 16:40:03 INFO - Running main action method: install 16:40:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:40:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:40:03 INFO - Reading from file tmpfile_stdout 16:40:03 INFO - Detecting whether we're running mozinstall >=1.0... 16:40:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:40:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:40:03 INFO - Reading from file tmpfile_stdout 16:40:03 INFO - Output received: 16:40:03 INFO - Usage: mozinstall [options] installer 16:40:03 INFO - Options: 16:40:03 INFO - -h, --help show this help message and exit 16:40:03 INFO - -d DEST, --destination=DEST 16:40:03 INFO - Directory to install application into. [default: 16:40:03 INFO - "/builds/slave/test"] 16:40:03 INFO - --app=APP Application being installed. [default: firefox] 16:40:03 INFO - mkdir: /builds/slave/test/build/application 16:40:03 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'] 16:40:03 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 16:40:37 INFO - Reading from file tmpfile_stdout 16:40:37 INFO - Output received: 16:40:37 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:40:37 INFO - Running post-action listener: _resource_record_post_action 16:40:37 INFO - ##### 16:40:37 INFO - ##### Running run-tests step. 16:40:37 INFO - ##### 16:40:37 INFO - Running pre-action listener: _resource_record_pre_action 16:40:37 INFO - Running main action method: run_tests 16:40:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:40:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:40:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:40:37 INFO - 2016-02-23 16:40:37.936 screenresolution[1654:7425] starting screenresolution argv=screenresolution get 16:40:37 INFO - 2016-02-23 16:40:37.938 screenresolution[1654:7425] Display 0: 1600x1200x32@60 16:40:37 INFO - 2016-02-23 16:40:37.945 screenresolution[1655:7427] starting screenresolution argv=screenresolution list 16:40:37 INFO - Available Modes on Display 0 16:40:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:40:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:40:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:40:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:40:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:40:38 INFO - Intel Iris: 16:40:38 INFO - Chipset Model: Intel Iris 16:40:38 INFO - Type: GPU 16:40:38 INFO - Bus: Built-In 16:40:38 INFO - VRAM (Dynamic, Max): 1536 MB 16:40:38 INFO - Vendor: Intel (0x8086) 16:40:38 INFO - Device ID: 0x0a2e 16:40:38 INFO - Revision ID: 0x0009 16:40:38 INFO - Displays: 16:40:38 INFO - Display: 16:40:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:40:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:40:38 INFO - Display Serial Number: 1600x1200 60 16:40:38 INFO - Main Display: Yes 16:40:38 INFO - Mirror: Off 16:40:38 INFO - Online: Yes 16:40:38 INFO - Rotation: Supported 16:40:38 INFO - Return code: 0 16:40:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:40:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:40:38 INFO - Python 2.7.3 16:40:38 INFO - Return code: 0 16:40:38 INFO - grabbing minidump binary from tooltool 16:40:38 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')]} 16:40:38 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 0x109977d30>, '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 0x10979bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10996eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:40:38 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 16:40:38 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 16:40:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:40:38 INFO - Return code: 0 16:40:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:40:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:40:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:40:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:40:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:40:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:40:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:40:39 INFO - Return code: 0 16:40:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Xou6s2awTtGEdQ3-fH3PpA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:40:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Xou6s2awTtGEdQ3-fH3PpA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0019 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:40:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2XIKlUP7ec/Render', 16:40:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:40:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:40:39 INFO - 'HOME': '/Users/cltbld', 16:40:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:40:39 INFO - 'LOGNAME': 'cltbld', 16:40:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:40:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:40:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:40:39 INFO - 'MOZ_NO_REMOTE': '1', 16:40:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:40:39 INFO - 'NO_EM_RESTART': '1', 16:40:39 INFO - 'PAGER': '/bin/cat', 16:40:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:40:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:40:39 INFO - 'PWD': '/builds/slave/test', 16:40:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:40:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:40:39 INFO - 'SHELL': '/bin/bash', 16:40:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WcVVfVnPUq/Listeners', 16:40:39 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 16:40:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:40:39 INFO - 'USER': 'cltbld', 16:40:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:40:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:40:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:40:39 INFO - 'XPC_FLAGS': '0x0', 16:40:39 INFO - 'XPC_SERVICE_NAME': '0', 16:40:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:40:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Xou6s2awTtGEdQ3-fH3PpA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:40:39 INFO - mozversion application_buildid: 20160223153946 16:40:39 INFO - mozversion application_changeset: dca97b7dfd1f46bacc098f21315640231f93ef68 16:40:39 INFO - mozversion application_display_name: Nightly 16:40:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:40:39 INFO - mozversion application_name: Firefox 16:40:39 INFO - mozversion application_remotingname: firefox 16:40:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:40:39 INFO - mozversion application_vendor: Mozilla 16:40:39 INFO - mozversion application_version: 47.0a1 16:40:39 INFO - mozversion platform_buildid: 20160223153946 16:40:39 INFO - mozversion platform_changeset: dca97b7dfd1f46bacc098f21315640231f93ef68 16:40:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:40:39 INFO - mozversion platform_version: 47.0a1 16:40:39 INFO - using testdate: 1456274439 16:40:39 INFO - actual date: 1456274439 16:40:40 INFO - starting webserver on 'localhost:49274' 16:40:40 INFO - SUITE-START | Running 2 tests 16:40:40 INFO - TEST-START | dromaeo_css 16:40:40 INFO - operating with platform_type : mac_ 16:40:40 INFO - Initialising browser for dromaeo_css test... 16:40:40 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/tmpjTVJjg/profile http://localhost:49274/getInfo.html) 16:40:43 INFO - PROCESS | 1673 | __metrics Screen width/height:1600/1200 16:40:43 INFO - PROCESS | 1673 | colorDepth:24 16:40:43 INFO - PROCESS | 1673 | Browser inner width/height: 1024/689 16:40:43 INFO - PROCESS | 1673 | __metrics 16:40:43 ERROR - PROCESS | 1673 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 16:40:43 INFO - TEST-INFO | 1673: exit 0 16:40:43 INFO - Browser initialized. 16:40:43 INFO - Running cycle 1/1 for dromaeo_css test... 16:40:43 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/tmpjTVJjg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:40:55 INFO - PROCESS | 1677 | RSS: Main: 256806912 16:40:55 INFO - PROCESS | 1677 | 16:41:45 INFO - PROCESS | 1677 | 1456274505591 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] 16:43:56 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 16:43:57 INFO - PROCESS | 1677 | RSS: Main: 268070912 16:43:57 INFO - PROCESS | 1677 | 16:46:59 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 16:47:00 INFO - PROCESS | 1677 | RSS: Main: 281219072 16:47:00 INFO - PROCESS | 1677 | 16:50:01 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 16:50:02 INFO - PROCESS | 1677 | RSS: Main: 282103808 16:50:02 INFO - PROCESS | 1677 | 16:53:04 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 16:53:04 INFO - PROCESS | 1677 | RSS: Main: 283901952 16:53:04 INFO - PROCESS | 1677 | 16:56:07 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 16:56:08 INFO - PROCESS | 1677 | RSS: Main: 285868032 16:56:08 INFO - PROCESS | 1677 | 16:59:10 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 16:59:10 INFO - PROCESS | 1677 | RSS: Main: 287981568 16:59:10 INFO - PROCESS | 1677 | 16:59:10 INFO - PROCESS | 1677 | __start_tp_report 16:59:10 INFO - PROCESS | 1677 | _x_x_mozilla_page_load 16:59:10 INFO - PROCESS | 1677 | _x_x_mozilla_page_load_details 16:59:10 INFO - PROCESS | 1677 | |i|pagename|runs| 16:59:10 INFO - PROCESS | 1677 | |0;dojo.html;3078.1688943985123;3310.4703247480393;3339.71612412945;3553.662402071804;3596.4605309203635;5642.6050176487615;5647.689377084259;5687.090065589501;5701.486866182043;5719.942800572004;4429.379886815848;5709.685967271798;5741.339745929219;5745.109508026252;5831.504322132613;4405.779711014453;5159.148740457829;5198.610104242178;5212.139996900507;5334.679919204841;5220.504052115062;5270.525652691257;5274.604404669646;5289.841304760864;5305.761240744157;5145.253938178962;5220.947790522122;5250.9737451312885;5271.393789714193;5298.629095963265;5168.974155129238;5192;5199.584033277329;5203.505666961632;5278.287431196816;4211.368294755781;5178.818741344035;5179.093658609729;5185.611079169077;5206.921896171561;5437.8368648940195;5460.590455715797;5488.957098151339;5553.805616803393;5558.666480011172;6117.296510901258;6189.102580125857;6197.03945888388;6215.34738852423;6252.749890004395;6111.786087486917;6137.407629318945;6160.969195154041;6173.32093469718;6207.782727604557;5852.531797456193;5874.295084589834;5876.588638795286;5880.764769409261;5904.0258357370985;6135.538906164978;6245.156903818017;6316.589421687576;6325.430711236011;6332.936670633235;5653.406392328829;6158.876822463526;6183.721732522047;6184.783532576338;6215.627062376181;6182.562259819299;6221.253449586078;6229.377062293825;6245.812625621239;6257.436830685169;6088.330283668793;6125.235451818339;6201.751929922752;6245.0320200369015;6259.843503912439;6199.28708198563;6228.377162283736;6238.376162383725;6249.093881387264;6255.874882502416;4802.543758342952;4915.016996600622;4918.754062296871;4923.606111511071;4948.678335908155;3856.749311294813;4308.159908817751;4361.367601697736;4372.366006928977;4424.358468022118;5881.176635271066;5892.882142357129;5920.378360272195;5921.73352199152;5933.881322373529;4923.655344125877;6103.701349646901;6131.3766666500715;6186.876262474815;6238.438540531374;5883.117532370093;5900;5936.821895343147;5952.702364881825;5963.135345374896;5405.729713514309;5416.864578385572;5426.9185962210595;5429.728513574306;5440.700761458079;6248.156498872685;6319.05214217871;6364.904526432108;6403.64779937108;6411.134496842867;5305.840824775263;5463.726813659222;6115.235595550556;6189.876202475835;6251.906221406592;6073;6240.656763878031;6396.456301214449;6402.711877965596;6416.615003099829;5103.260027296095;6117.766507567632;6241.843953901189;6243.719032643451;6268.122462855113;6176.197094377702;6178.845528861634;6195.566310358232;6207.565470417027;6215.627062376272;5349.304590403222;5436.6194366393975;6110.984061328523;6165.907511387422;6178.196834411678;6106.179736190777;6148.231471066117;6167.629942203482;6178.073289006685;6198.566100372931;5881.235439392852;5993.0710739835395;5996.730147143302;6027.21646185993;6030.819075427744;6005.189299444519;6102.809952059306;6116.785912493041;6182.443580077815;6186.319504854552;6039.698015099139;6062.727177277121;6063.333033366238;6065.2418447694035;6084.908726369196 16:59:10 INFO - PROCESS | 1677 | |1;ext.html;469.94595621503515;520.0846510142151;524.7428759907647;595.8421018430117;612.1368869893452;38029.80985095074;38619.613803861954;38655;38757.80621096894;38757.99999999996;38786.80606596963;39224.41163382552;39246.8037659812;39263.41104883429;39380.40929386061;9369.43783372998;9698.272629552777;9723.319367644268;9747.658831940884;9750.658726944559;9586.808263834719;9606;9691.563879625433;9834.360766550188;9872.407655540655;9780.364276322016;9835.967223441507;9844.310898237127;9886.456244906527;9914.305998580103;9762.658306959258;9781.266405019653;9865.950670246675;9869.259805514579;9875.259355548327;9067.68263110788;9132.99537050924;9849.704508864745;9859.556319965619;9863.556139973718;37952.43071353932;38206.617933820584;38656.80671596652;38733.80633096817;38899.52655444632;3414;3512.631173726773;3737.2525494900856;3787.8636409077167;4029.637332640047;29503.852480737674;29702.96039638624;29728.364939928295;29851.402971940657;29918.700812992025;2761.9171424857286;2834.985825070882;2877.4676684813376;2917.9270518237213;3005.2637103909465;390516;473324;479114;479544;480619;45496.09007819825;46015.53984460179;46026.84932876705;46097.53902460999;46166.76916615463;44306.55693443089;44444.77777611091;44638.55361446409;44747.88130296769;44934.876628083905;15091.01908375952;15196.240187990556;15234.771478427832;15255.542333730005;15286.312115954808;12092.395380230953;12102.878971210352;12190.57332993341;12277.631671049883;12704.3012634306;12318.445669944875;14835.887308451693;14877.628059298388;14881.925590371979;14922.403103875724;6461.127747754087;6563.113979612786;6569.868602627921;6580.440662543738;6599;969.2585172343163;971.3491960386558;1038.5326603028668;1059.8569193158978;1119.5689659481159;27055.458890822072;32148.83925580357;32961.83519082437;33022;33203.50194747081;1059.9364038157735;1080.9513571889127;1119.9832002519968;1131.4738646529404;1180.138498895811;14369.78445323321;14587.978841480994;14599.416023358946;15972.76040859388;16093.919530402507;590356;606566;607076;607384;611213;51129;60585.09122363168;60841.69579152076;61397.38602614006;61464.69267653633;1453.9054961427473;1455.2650911289732;1457.1330058614894;1464.048368560423;1589.6343840916422;30908;30944.69055309418;31045;31462;31623.683763162073;56065.43934560602;56293.43706562882;57021;57072.71463642655;57224;414296;416221;417463;418130;418720.8127918804;44325.89185270394;44519.55480445154;44525.777371112934;44883.55116448794;44916.77541612271;46270.305945410175;46368.30447543222;46869.2969605463;47421.52578474171;47559.286610700176;37933.24133517369;38373.808130959165;39091.804540977115;39269;39307.410388843615;39733.60266397299;40118.39822402608;40227;40722.59277407306;40839;37466.2506749858;37473.688420905135;37661.246775064894;38634;38750.80624596859;29583;30479.933202337812;31140.844295778377;31857.8407107963;32157.356852862344;23811.166609168595;25013.74986250187;25246.12661349628;25275.74724252734;25579.744202557737 16:59:10 INFO - PROCESS | 1677 | |2;jquery.html;308.5110100490722;356.0440218014631;358.50168266110103;359.7571639143578;365.85365853658516;15529.456469023586;18478.630427391443;18546.07269636518;19576.51058723529;20177.798222017776;11788.056955443566;12173.087018473605;12259.957903578184;19817;20080.196792128332;5238.292830467895;5382.703951282678;5384.488473595002;5406;5416.891662166754;5374.892502149954;5882.3823498532465;5942.049272116462;5943.375945525722;5947.048472244442;5789.247397838275;5834.5915785895;5874.295084589855;5910.143029260755;6182.938170618304;5926.940730592682;6096.055111457709;6131.325554189058;6131.9386806131815;6155.353687862777;5507.449255074501;5578.107502799533;5582.162675598652;5588.916166257469;5608.018596745594;13089.934550327283;13116.803247951288;13202.66993325165;13297.202167869958;13376;2056.331692200041;2095.8637688550198;2137.5831712816007;2539.2255362114547;2791.623130877326;8592.754050662681;8729;9431.669891553762;9914.25643076765;13233;1634.1665750467228;1709.2223038517445;1753.6492701459758;1788.5081602559271;1841.9316796258138;98982.010179898;104426;105383;106000.93999060064;106259.46870265677;9923.354981926152;11148.275362101438;11398.917102875213;11507.252028618113;11535.134864885;11825.88174118265;12023;13038.348082595832;13455.192688438725;13588.59234222975;8337.333013358917;8525.573721314033;8646.956765216259;8695.347848911357;8759.912400876037;8670.653173873101;8729.956350218208;8792.384533082623;8797.208251257418;8851.734447966572;3760.8683696070507;4413.713108647992;4492.887677808081;4521.773911304422;4539.296409056601;1734.3929624631278;1844.1701234444554;1934.458351661537;1945.8443324534003;1949.3079956615481;809.4697972827689;832.3923535818886;853.6158728572043;953.0897992417225;1044.7910417916446;19537.316193933144;20096.296629617893;20194.990250487415;20352.796472035385;20573.971301434867;928.1646518133733;940.3840484482674;978.9902100978899;998.6554638649654;1030;10495.370277783357;10777.245592808427;10986.780264394667;10986.835197472044;11008.614698485675;279106.60446697637;280833;281698;355974;596711;111770;115765;116965;118299;119730.20404693937;858.5878778186506;880.7093659092484;1025.707673313117;1033.6898930320874;1037.7613148975777;17509.474715758548;18158.636827263646;18260.72608910894;18800.247990080243;18847.434576962714;41138.79430602828;48206.75896620494;48543.271850922974;49371.27200547964;50267.497325026285;62454.37545624667;72742;76336.61831690806;76589.08527286639;77527.34835909863;7909.090454597795;8006.319462845723;8161.755147345589;8292.502449853027;8347.707830225912;9261.120193581599;12914.22514649124;13662.31688415595;13686.65783355424;13696.86303136956;11132.165087618623;11430.542778289107;11549.133814963743;11590.826137607773;11744.647660570197;11181.385023823768;11211.66365009051;11285.32288062686;11343.886561134283;11591.942040289745;11396.518452601109;11611.013063889664;11981.04151667847;11997.76004479923;12067;8073;8251.628676709443;8257.42198046155;8311.667533298842;8355.621322481966;9495.38280011797;11880.465379058136;11895.702607434883;11930.164888457724;11989.700257493632 16:59:10 INFO - PROCESS | 1677 | |3;mootools.html;1555.5799934017816;1581.3437423469256;1828.4331857124293;1926.9518262043448;1929.093326136717;7742.341900938427;8561.443506172094;8652.653893844246;8881.955590222047;9362.01698821624;7956.124826269106;8267.966504186976;8633;8740.475571465717;8804.20762131408;2363.58637238483;2385.7494963028894;2389.4145934246135;2395.3652282145244;2398.5922393193114;2319.895604697784;2389.4026493376655;2449.8407603505716;2450.3261603059213;2456.6069428891383;2145.2598853395552;2425.987870060656;2456.5455390752677;2470.888810003545;2475.7497463780765;2424.9151279705125;2449.448874003353;2468.6297055441737;2512.1207577347964;2515.861627610481;2486.316263027664;2504.2362079565723;2507.736687647789;2519.596864501671;2536.7463253674487;8753.212210900985;8771.912280877174;8776.64893404263;8806.691765788166;8819;5449.291592093042;5604.579656525777;5606.915896261559;5607.467290607386;5636;3650.5254316938626;3666.5416822897137;3708.9072773180887;3795.810209489542;3801.258754542865;1050.0811789684026;1058.2486434631421;1062.1555863088863;1104.36499013067;1105.701460605632;12000.159988800788;12033.278003319829;12038.939805301005;12114;12176.695582610417;4709.670323077352;4721.763911804396;4773.11697335994;4804.711717296974;4817.662763606514;9340.4862732549;9442.48066356357;9456.952715236517;9463.195628371528;9475.763105922408;5389.218563308376;5393.649412788156;5451.64564303319;5454.61817672767;5479.863003424946;4057.3711074783455;4461.107778444324;4931.5315045070665;4932.161532539477;4978.950210497921;3793;3805.1058001369656;3828.3109040373;3852.152526444178;3853.7475320520384;1034.5654824973378;1176.2178151529138;1189.3755778216332;1194.904407647386;1196.3300551690907;1327.6680829792551;1339.912905661129;1349.379285528648;1357.4434481862586;1368.50733735855;8181.263686268146;8261.504309741315;8293.377996650275;8306.04480484752;8345.290650294672;485.2454433356165;487.96584239102924;489.99265011024863;493.4054464370425;513.637885290869;6176.66028368444;6221.191245138103;6240.438360547572;6244.46922011625;6257.468115210167;10286.125679317342;10491.895081049244;10578.894211057945;10581.206409519164;10628.946855265674;10190.643327483502;10399.792004159874;10411.531481083219;10435.37387756737;10499.632512862167;7152.570845749272;8141.43009989295;8244.29923456513;8289.839422480858;8365.62354694028;7945.284924356835;7991.600419979094;8010.158933311918;8014;8267.379946504156;9574.617015319309;9637.036296370306;9696.0788725071;9701.126898579161;9843.85234221473;9580.473073980998;9793.216542676711;9876.703698888758;9943.900560994298;9974.501274936369;6784.76253331131;7190.7483238086415;7426.777196684108;7456.403487721078;7529.73645922412;6905.516613836983;7019.29807019294;8185.877211841708;8245.587720614065;8247.917520824954;6724.125863637696;6732.596044237362;7311.817204569928;7358.448116391185;7494.662740176815;7269.927300726925;7279.090113735783;7305.890411643936;7306.1963184048645;7358.080239970004;7556.622168891643;7672.6547305372505;7713.730019449293;7714.4599878008;7715.768526944201;6981.0924579804305;7043.36609705129;7069.328413800681;7071.82320441993;7080.185778635523;6427.517936154713;6875.7937261882225;7157.284271572801;7179.1026121734785;7183.892241616275 16:59:10 INFO - PROCESS | 1677 | |4;prototype.html;315.9826209558474;321.8390804597701;326.03656195941;326.3635909975548;329.9076258647578;6730.427913627335;6829.385355318021;6837.145356830396;6985.825354366143;7031.578105313684;6727.562708423949;6811.523193376465;6821.113255276807;6821.9658901705425;6896.379325860671;5069.645124841244;5082.847514574551;5084.3136176616235;5086.6693664911845;5087.058894104584;5067.974660126694;5088.974555127219;5094.006668699605;5098.821541246057;5122.436531981479;5023.346964894558;5033.842216290255;5035.496450354972;5041.067402530525;5048.5203905628905;4081.795910204493;4829.227323628238;4965.354503914504;5045.873853153664;5055.292259083732;4229.842780182098;4279.807408666617;4296.63478604319;4304.053108316197;4315.568443155659;6589.505787065989;6597.967010164918;6599.3400659934105;6628.072069910217;6647.368499992493;5627.915581266284;5840.868083149619;5849.122631605251;5875.385453473206;5896.734646940898;7243.782686519413;7247.528910620793;7253.891191632129;7267.200607933123;7286.016387787687;4592.954070459286;4612.907741845178;4616.561426664462;4621;4623.514530974233;7748.496347737436;7839.529628222268;7846.568438735867;7851.0186226722235;7878.330341920886;4556.954430455653;4653.930191047137;4687.671862969628;4688.296755486636;4689.015306785614;4758.381410416624;4781.043791241766;4781.593564546983;4782.33047373361;4788.784504697297;4773.331733557305;5405.8107966221;5757.309122905278;5757.88484230313;5758.1650660654805;7277.981082648434;7287.344139027513;7308.853822923512;7309.122905251404;7315.341619254186;1343.8656134386483;1654.2886558779599;1659.8755093368045;1660.1699150424788;1666.575023369033;988.5106872098357;1027.3527677563088;1041.9216111324743;1067.1356201476829;1086.5708045322212;6648;6704.698288577026;6731.663416829237;6744.966275168691;6753.594784312957;7309;7321.121465424183;7326.047613810277;7386.0767404074495;7406.555606663617;6755.628440435823;6757.290484499057;6765.966170169216;6792.490563207779;6813.7955861324235;3171.413288541581;3681.171736359298;4011.5988401160234;4024.8993775155855;4042.5351084625645;7905.367570594339;8044.155363686846;8103.675852965934;8108;8137;6359.682015899187;6603.900941485882;7677.731279405306;7937.642806073741;7963.482373645695;6350.8412289692205;8012.959935200403;8015.198480152055;8024.839503209903;8033.517988920684;7352.338289553966;7688.423368247292;7706.152323244327;7715.881197226483;7719.691212351668;6248.968755156195;7277.490575659653;7532.284432978859;7533.660985255787;7540.547567145989;8053.154418785943;8053.838923221386;8065.83868322642;8070;8081.515109093473;4722.291656251589;4734.905301894012;4735.147673418817;4740.644451666208;4746.288056791509;7395.593242371721;7629.6566654499575;7679.462437629312;7726.845463090594;7760.92239077602;7419.703211871465;7465.440091993014;7467.327940485382;7500.887486687813;7507.099148102263;7388.667509961957;7406.888896666446;7417.258274172756;7422.294881986203;7452.739154129579;7028.718851245892;7279;7295.963520182365;7298.635068246673;7299.343059124704;7386.889196662162;7437.442191835526;7448.106227252764;7450.441216908862;7503.324700776956;7261.963690181516;7280.344768970818;7294.671739771617;7295.270472952662;7308.780736577911 16:59:10 INFO - PROCESS | 1677 | |5;yui.html;601.1553766957425;661.5005670718607;699.8506719761075;711.7544447165726;731.4514114414189;14199.432022719104;14979.325930333134;15194.848051519495;15236.1620110894;15493.992890462141;13507.324633768321;15343.232838358093;15473.845261547382;15496.535103946899;15497.992630479011;841.8316336732647;848.1476116502906;857.5069335132292;858.4891989266376;859.8710193470966;836.1178956201205;844.1474111147724;846.1411667157839;847.737201467544;848.7835601921502;886.2998231397221;892.0499667853747;892.0811564088999;895.5208963204686;901.0268909577674;879.1604018162672;881.088073843572;886.1714297132202;892.2861710631469;893.9016708162097;554.9833504994857;655.3806652713188;662.483263054818;672.4922683374022;675.1729131813538;14899.851001489955;14972.850271497255;15059.472918447802;15091.24543772807;15147.621309467242;12103.878961210363;12149.392530373534;12242.204256723373;12538.68653283666;12600.117991740583;9962.750931226778;9987.500624968796;10084.042016008467;10133.277342851732;10143.543540540693;3304.6695330467;3341.6992470677515;3402.0644322811177;3426.4860270959557;3532.8410221540094;72781.27218727798;73382.63308683422;83098.58450707707;83896;83978.16021839765;9307.72076837696;9315.813683726288;9322.440653560809;9360.251179905592;9621.615135394506;20602.690959635616;20644.277450289166;20784.48038799042;20788.688169677465;20862.687059694115;7326;7332.670029848669;7458.813529661693;7603;7718.151003389623;4097.610726980932;4134.836368690351;4136.793160341971;4212.978935105305;4326.913461730748;3452.637473065292;3474.42671959129;3474.8783792567137;3475.3570589441033;3481.112316359312;517.4799326676666;611.8837420890017;618.8267285160073;633.7369991453495;646.0083771410862;565.3922033813667;588.7262422973338;597.8505373656586;624.4202168513667;631.4727202785725;6818.28408017151;7940.205979402129;8360.790980225422;8521.147885211429;9089.681861134828;538.4185080113468;585.1544518171287;602.9879402411927;606.9362716914749;621.3910367839543;3967;3980.800959951991;4046.3728122141115;4056.59434056592;4146.360949109209;65552;81262.59368703119;90344;90776.09223907809;90837.54581227184;64869.35130648633;65712.75728805852;75801.24198757941;76761.61619191869;76996.61501692455;60728;61473.38526614677;64341.678291608245;66037.66981165063;68543;8788.384813063025;8806.64773409082;8874.169562677771;8994.280457563249;9013.459192448474;46064.8483787908;46393.376231831724;47107;47289.52710472851;48528.54414367575;57530.42469575251;62478.37521624907;67869;68041.63916721736;68653;10630;10691.732706682395;10822.296550724177;10889.397376072813;11530.308181509135;11803.23278986863;11811.940940295244;11813.291202527877;12044.337561434206;12332.383380831103;10850.94574527154;11390.772184556428;11442;11633.429487019144;11756.58851940178;11001.504932278227;11613.477393517482;11635.47640356169;11653.475593598478;12231.816522751988;11072.169587280825;11370.488328025092;11407.771844563229;11446.771064578828;11987.580434684744;9349.53252337394;9545.665901693408;9737.707868763948;9829.459379734184;10209.540570674486;8162.0613629431;8686.652533898574;9565.952170239105;9872.605095796087;9899.851502227617 16:59:10 INFO - PROCESS | 1677 | __end_tp_report 16:59:10 INFO - PROCESS | 1677 | __start_cc_report 16:59:10 INFO - PROCESS | 1677 | _x_x_mozilla_cycle_collect,341 16:59:10 INFO - PROCESS | 1677 | __end_cc_report 16:59:10 INFO - PROCESS | 1677 | __startTimestamp1456275550694__endTimestamp 16:59:10 INFO - PROCESS | 1677 | 16:59:10 INFO - PROCESS | 1677 | ------- Summary: start ------- 16:59:10 INFO - PROCESS | 1677 | Number of tests: 6 16:59:10 INFO - PROCESS | 1677 | 16:59:10 INFO - PROCESS | 1677 | [#0] dojo.html Cycles:165 Average:5705.33 Median:5963.14 stddev:675.07 (11.3%) stddev-sans-first:644.91 16:59:10 INFO - PROCESS | 1677 | Values: 3078.2 3310.5 3339.7 3553.7 3596.5 5642.6 5647.7 5687.1 5701.5 5719.9 4429.4 5709.7 5741.3 5745.1 5831.5 4405.8 5159.1 5198.6 5212.1 5334.7 5220.5 5270.5 5274.6 5289.8 5305.8 5145.3 5220.9 5251.0 5271.4 5298.6 5169.0 5192.0 5199.6 5203.5 5278.3 4211.4 5178.8 5179.1 5185.6 5206.9 5437.8 5460.6 5489.0 5553.8 5558.7 6117.3 6189.1 6197.0 6215.3 6252.7 6111.8 6137.4 6161.0 6173.3 6207.8 5852.5 5874.3 5876.6 5880.8 5904.0 6135.5 6245.2 6316.6 6325.4 6332.9 5653.4 6158.9 6183.7 6184.8 6215.6 6182.6 6221.3 6229.4 6245.8 6257.4 6088.3 6125.2 6201.8 6245.0 6259.8 6199.3 6228.4 6238.4 6249.1 6255.9 4802.5 4915.0 4918.8 4923.6 4948.7 3856.7 4308.2 4361.4 4372.4 4424.4 5881.2 5892.9 5920.4 5921.7 5933.9 4923.7 6103.7 6131.4 6186.9 6238.4 5883.1 5900.0 5936.8 5952.7 5963.1 5405.7 5416.9 5426.9 5429.7 5440.7 6248.2 6319.1 6364.9 6403.6 6411.1 5305.8 5463.7 6115.2 6189.9 6251.9 6073.0 6240.7 6396.5 6402.7 6416.6 5103.3 6117.8 6241.8 6243.7 6268.1 6176.2 6178.8 6195.6 6207.6 6215.6 5349.3 5436.6 6111.0 6165.9 6178.2 6106.2 6148.2 6167.6 6178.1 6198.6 5881.2 5993.1 5996.7 6027.2 6030.8 6005.2 6102.8 6116.8 6182.4 6186.3 6039.7 6062.7 6063.3 6065.2 6084.9 16:59:10 INFO - PROCESS | 1677 | 16:59:10 INFO - PROCESS | 1677 | [#1] ext.html Cycles:180 Average:63470.33 Median:39288.21 stddev:133460.76 (339.7%) stddev-sans-first:133751.33 16:59:10 INFO - PROCESS | 1677 | Values: 469.9 520.1 524.7 595.8 612.1 38029.8 38619.6 38655.0 38757.8 38758.0 38786.8 39224.4 39246.8 39263.4 39380.4 9369.4 9698.3 9723.3 9747.7 9750.7 9586.8 9606.0 9691.6 9834.4 9872.4 9780.4 9836.0 9844.3 9886.5 9914.3 9762.7 9781.3 9866.0 9869.3 9875.3 9067.7 9133.0 9849.7 9859.6 9863.6 37952.4 38206.6 38656.8 38733.8 38899.5 3414.0 3512.6 3737.3 3787.9 4029.6 29503.9 29703.0 29728.4 29851.4 29918.7 2761.9 2835.0 2877.5 2917.9 3005.3 390516.0 473324.0 479114.0 479544.0 480619.0 45496.1 46015.5 46026.8 46097.5 46166.8 44306.6 44444.8 44638.6 44747.9 44934.9 15091.0 15196.2 15234.8 15255.5 15286.3 12092.4 12102.9 12190.6 12277.6 12704.3 12318.4 14835.9 14877.6 14881.9 14922.4 6461.1 6563.1 6569.9 6580.4 6599.0 969.3 971.3 1038.5 1059.9 1119.6 27055.5 32148.8 32961.8 33022.0 33203.5 1059.9 1081.0 1120.0 1131.5 1180.1 14369.8 14588.0 14599.4 15972.8 16093.9 590356.0 606566.0 607076.0 607384.0 611213.0 51129.0 60585.1 60841.7 61397.4 61464.7 1453.9 1455.3 1457.1 1464.0 1589.6 30908.0 30944.7 31045.0 31462.0 31623.7 56065.4 56293.4 57021.0 57072.7 57224.0 414296.0 416221.0 417463.0 418130.0 418720.8 44325.9 44519.6 44525.8 44883.6 44916.8 46270.3 46368.3 46869.3 47421.5 47559.3 37933.2 38373.8 39091.8 39269.0 39307.4 39733.6 40118.4 40227.0 40722.6 40839.0 37466.3 37473.7 37661.2 38634.0 38750.8 29583.0 30479.9 31140.8 31857.8 32157.4 23811.2 25013.7 25246.1 25275.7 25579.7 16:59:10 INFO - PROCESS | 1677 | 16:59:10 INFO - PROCESS | 1677 | [#2] jquery.html Cycles:180 Average:26805.99 Median:2665.42 stddev:65416.76 (2454.3%) stddev-sans-first:65570.02 16:59:10 INFO - PROCESS | 1677 | Values: 308.5 356.0 358.5 359.8 365.9 15529.5 18478.6 18546.1 19576.5 20177.8 11788.1 12173.1 12260.0 19817.0 20080.2 5238.3 5382.7 5384.5 5406.0 5416.9 5374.9 5882.4 5942.0 5943.4 5947.0 5789.2 5834.6 5874.3 5910.1 6182.9 5926.9 6096.1 6131.3 6131.9 6155.4 5507.4 5578.1 5582.2 5588.9 5608.0 13089.9 13116.8 13202.7 13297.2 13376.0 2056.3 2095.9 2137.6 2539.2 2791.6 8592.8 8729.0 9431.7 9914.3 13233.0 1634.2 1709.2 1753.6 1788.5 1841.9 98982.0 104426.0 105383.0 106000.9 106259.5 9923.4 11148.3 11398.9 11507.3 11535.1 11825.9 12023.0 13038.3 13455.2 13588.6 8337.3 8525.6 8647.0 8695.3 8759.9 8670.7 8730.0 8792.4 8797.2 8851.7 3760.9 4413.7 4492.9 4521.8 4539.3 1734.4 1844.2 1934.5 1945.8 1949.3 809.5 832.4 853.6 953.1 1044.8 19537.3 20096.3 20195.0 20352.8 20574.0 928.2 940.4 979.0 998.7 1030.0 10495.4 10777.2 10986.8 10986.8 11008.6 279106.6 280833.0 281698.0 355974.0 596711.0 111770.0 115765.0 116965.0 118299.0 119730.2 858.6 880.7 1025.7 1033.7 1037.8 17509.5 18158.6 18260.7 18800.2 18847.4 41138.8 48206.8 48543.3 49371.3 50267.5 62454.4 72742.0 76336.6 76589.1 77527.3 7909.1 8006.3 8161.8 8292.5 8347.7 9261.1 12914.2 13662.3 13686.7 13696.9 11132.2 11430.5 11549.1 11590.8 11744.6 11181.4 11211.7 11285.3 11343.9 11591.9 11396.5 11611.0 11981.0 11997.8 12067.0 8073.0 8251.6 8257.4 8311.7 8355.6 9495.4 11880.5 11895.7 11930.2 11989.7 16:59:10 INFO - PROCESS | 1677 | 16:59:10 INFO - PROCESS | 1677 | [#3] mootools.html Cycles:180 Average:5988.03 Median:5542.22 stddev:3170.09 (57.2%) stddev-sans-first:3161.48 16:59:10 INFO - PROCESS | 1677 | Values: 1555.6 1581.3 1828.4 1927.0 1929.1 7742.3 8561.4 8652.7 8882.0 9362.0 7956.1 8268.0 8633.0 8740.5 8804.2 2363.6 2385.7 2389.4 2395.4 2398.6 2319.9 2389.4 2449.8 2450.3 2456.6 2145.3 2426.0 2456.5 2470.9 2475.7 2424.9 2449.4 2468.6 2512.1 2515.9 2486.3 2504.2 2507.7 2519.6 2536.7 8753.2 8771.9 8776.6 8806.7 8819.0 5449.3 5604.6 5606.9 5607.5 5636.0 3650.5 3666.5 3708.9 3795.8 3801.3 1050.1 1058.2 1062.2 1104.4 1105.7 12000.2 12033.3 12038.9 12114.0 12176.7 4709.7 4721.8 4773.1 4804.7 4817.7 9340.5 9442.5 9457.0 9463.2 9475.8 5389.2 5393.6 5451.6 5454.6 5479.9 4057.4 4461.1 4931.5 4932.2 4979.0 3793.0 3805.1 3828.3 3852.2 3853.7 1034.6 1176.2 1189.4 1194.9 1196.3 1327.7 1339.9 1349.4 1357.4 1368.5 8181.3 8261.5 8293.4 8306.0 8345.3 485.2 488.0 490.0 493.4 513.6 6176.7 6221.2 6240.4 6244.5 6257.5 10286.1 10491.9 10578.9 10581.2 10628.9 10190.6 10399.8 10411.5 10435.4 10499.6 7152.6 8141.4 8244.3 8289.8 8365.6 7945.3 7991.6 8010.2 8014.0 8267.4 9574.6 9637.0 9696.1 9701.1 9843.9 9580.5 9793.2 9876.7 9943.9 9974.5 6784.8 7190.7 7426.8 7456.4 7529.7 6905.5 7019.3 8185.9 8245.6 8247.9 6724.1 6732.6 7311.8 7358.4 7494.7 7269.9 7279.1 7305.9 7306.2 7358.1 7556.6 7672.7 7713.7 7714.5 7715.8 6981.1 7043.4 7069.3 7071.8 7080.2 6427.5 6875.8 7157.3 7179.1 7183.9 16:59:10 INFO - PROCESS | 1677 | 16:59:10 INFO - PROCESS | 1677 | [#4] prototype.html Cycles:180 Average:5976.85 Median:6756.46 stddev:1960.66 (29.0%) stddev-sans-first:1919.57 16:59:10 INFO - PROCESS | 1677 | Values: 316.0 321.8 326.0 326.4 329.9 6730.4 6829.4 6837.1 6985.8 7031.6 6727.6 6811.5 6821.1 6822.0 6896.4 5069.6 5082.8 5084.3 5086.7 5087.1 5068.0 5089.0 5094.0 5098.8 5122.4 5023.3 5033.8 5035.5 5041.1 5048.5 4081.8 4829.2 4965.4 5045.9 5055.3 4229.8 4279.8 4296.6 4304.1 4315.6 6589.5 6598.0 6599.3 6628.1 6647.4 5627.9 5840.9 5849.1 5875.4 5896.7 7243.8 7247.5 7253.9 7267.2 7286.0 4593.0 4612.9 4616.6 4621.0 4623.5 7748.5 7839.5 7846.6 7851.0 7878.3 4557.0 4653.9 4687.7 4688.3 4689.0 4758.4 4781.0 4781.6 4782.3 4788.8 4773.3 5405.8 5757.3 5757.9 5758.2 7278.0 7287.3 7308.9 7309.1 7315.3 1343.9 1654.3 1659.9 1660.2 1666.6 988.5 1027.4 1041.9 1067.1 1086.6 6648.0 6704.7 6731.7 6745.0 6753.6 7309.0 7321.1 7326.0 7386.1 7406.6 6755.6 6757.3 6766.0 6792.5 6813.8 3171.4 3681.2 4011.6 4024.9 4042.5 7905.4 8044.2 8103.7 8108.0 8137.0 6359.7 6603.9 7677.7 7937.6 7963.5 6350.8 8013.0 8015.2 8024.8 8033.5 7352.3 7688.4 7706.2 7715.9 7719.7 6249.0 7277.5 7532.3 7533.7 7540.5 8053.2 8053.8 8065.8 8070.0 8081.5 4722.3 4734.9 4735.1 4740.6 4746.3 7395.6 7629.7 7679.5 7726.8 7760.9 7419.7 7465.4 7467.3 7500.9 7507.1 7388.7 7406.9 7417.3 7422.3 7452.7 7028.7 7279.0 7296.0 7298.6 7299.3 7386.9 7437.4 7448.1 7450.4 7503.3 7262.0 7280.3 7294.7 7295.3 7308.8 16:59:10 INFO - PROCESS | 1677 | 16:59:10 INFO - PROCESS | 1677 | [#5] yui.html Cycles:180 Average:17545.14 Median:30669.94 stddev:24058.33 (78.4%) stddev-sans-first:24092.18 16:59:10 INFO - PROCESS | 1677 | Values: 601.2 661.5 699.9 711.8 731.5 14199.4 14979.3 15194.8 15236.2 15494.0 13507.3 15343.2 15473.8 15496.5 15498.0 841.8 848.1 857.5 858.5 859.9 836.1 844.1 846.1 847.7 848.8 886.3 892.0 892.1 895.5 901.0 879.2 881.1 886.2 892.3 893.9 555.0 655.4 662.5 672.5 675.2 14899.9 14972.9 15059.5 15091.2 15147.6 12103.9 12149.4 12242.2 12538.7 12600.1 9962.8 9987.5 10084.0 10133.3 10143.5 3304.7 3341.7 3402.1 3426.5 3532.8 72781.3 73382.6 83098.6 83896.0 83978.2 9307.7 9315.8 9322.4 9360.3 9621.6 20602.7 20644.3 20784.5 20788.7 20862.7 7326.0 7332.7 7458.8 7603.0 7718.2 4097.6 4134.8 4136.8 4213.0 4326.9 3452.6 3474.4 3474.9 3475.4 3481.1 517.5 611.9 618.8 633.7 646.0 565.4 588.7 597.9 624.4 631.5 6818.3 7940.2 8360.8 8521.1 9089.7 538.4 585.2 603.0 606.9 621.4 3967.0 3980.8 4046.4 4056.6 4146.4 65552.0 81262.6 90344.0 90776.1 90837.5 64869.4 65712.8 75801.2 76761.6 76996.6 60728.0 61473.4 64341.7 66037.7 68543.0 8788.4 8806.6 8874.2 8994.3 9013.5 46064.8 46393.4 47107.0 47289.5 48528.5 57530.4 62478.4 67869.0 68041.6 68653.0 10630.0 10691.7 10822.3 10889.4 11530.3 11803.2 11811.9 11813.3 12044.3 12332.4 10850.9 11390.8 11442.0 11633.4 11756.6 11001.5 11613.5 11635.5 11653.5 12231.8 11072.2 11370.5 11407.8 11446.8 11987.6 9349.5 9545.7 9737.7 9829.5 10209.5 8162.1 8686.7 9566.0 9872.6 9899.9 16:59:10 INFO - PROCESS | 1677 | -------- Summary: end -------- 16:59:10 INFO - PROCESS | 1677 | 16:59:11 INFO - TEST-INFO | 1677: exit 0 16:59:11 INFO - TEST-OK | dromaeo_css | took 1111153ms 16:59:11 INFO - TEST-START | kraken 16:59:11 INFO - operating with platform_type : mac_ 16:59:11 INFO - Initialising browser for kraken test... 16:59:11 INFO - TEST-INFO | started process 1688 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/tmpR5sh_J/profile http://localhost:49274/getInfo.html) 16:59:14 INFO - PROCESS | 1688 | __metrics Screen width/height:1600/1200 16:59:14 INFO - PROCESS | 1688 | colorDepth:24 16:59:14 INFO - PROCESS | 1688 | Browser inner width/height: 1024/689 16:59:14 INFO - PROCESS | 1688 | __metrics 16:59:14 ERROR - PROCESS | 1688 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 16:59:14 INFO - TEST-INFO | 1688: exit 0 16:59:14 INFO - Browser initialized. 16:59:14 INFO - Running cycle 1/1 for kraken test... 16:59:14 INFO - TEST-INFO | started process 1691 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/tmpR5sh_J/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:59:26 INFO - PROCESS | 1691 | RSS: Main: 255967232 16:59:26 INFO - PROCESS | 1691 | 16:59:29 INFO - PROCESS | 1691 | 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) 16:59:30 INFO - PROCESS | 1691 | RSS: Main: 268857344 16:59:30 INFO - PROCESS | 1691 | 16:59:33 INFO - PROCESS | 1691 | 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) 16:59:33 INFO - PROCESS | 1691 | RSS: Main: 276262912 16:59:33 INFO - PROCESS | 1691 | 16:59:37 INFO - PROCESS | 1691 | 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) 16:59:37 INFO - PROCESS | 1691 | RSS: Main: 280653824 16:59:37 INFO - PROCESS | 1691 | 16:59:39 INFO - PROCESS | 1691 | 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) 16:59:40 INFO - PROCESS | 1691 | RSS: Main: 282030080 16:59:40 INFO - PROCESS | 1691 | 16:59:42 INFO - PROCESS | 1691 | 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) 16:59:43 INFO - PROCESS | 1691 | RSS: Main: 281038848 16:59:43 INFO - PROCESS | 1691 | 16:59:46 INFO - PROCESS | 1691 | 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) 16:59:46 INFO - PROCESS | 1691 | RSS: Main: 282099712 16:59:46 INFO - PROCESS | 1691 | 16:59:50 INFO - PROCESS | 1691 | 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) 16:59:50 INFO - PROCESS | 1691 | RSS: Main: 282509312 16:59:50 INFO - PROCESS | 1691 | 16:59:54 INFO - PROCESS | 1691 | 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) 16:59:54 INFO - PROCESS | 1691 | RSS: Main: 282353664 16:59:54 INFO - PROCESS | 1691 | 16:59:56 INFO - PROCESS | 1691 | 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) 16:59:56 INFO - PROCESS | 1691 | RSS: Main: 282664960 16:59:56 INFO - PROCESS | 1691 | 16:59:58 INFO - PROCESS | 1691 | 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) 16:59:59 INFO - PROCESS | 1691 | RSS: Main: 282308608 16:59:59 INFO - PROCESS | 1691 | 17:00:01 INFO - PROCESS | 1691 | 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) 17:00:02 INFO - PROCESS | 1691 | RSS: Main: 284491776 17:00:02 INFO - PROCESS | 1691 | 17:00:04 INFO - PROCESS | 1691 | 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) 17:00:05 INFO - PROCESS | 1691 | RSS: Main: 284520448 17:00:05 INFO - PROCESS | 1691 | 17:00:07 INFO - PROCESS | 1691 | 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) 17:00:08 INFO - PROCESS | 1691 | RSS: Main: 283254784 17:00:08 INFO - PROCESS | 1691 | 17:00:10 INFO - PROCESS | 1691 | 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) 17:00:10 INFO - PROCESS | 1691 | RSS: Main: 285351936 17:00:10 INFO - PROCESS | 1691 | 17:00:10 INFO - PROCESS | 1691 | __start_tp_report 17:00:10 INFO - PROCESS | 1691 | _x_x_mozilla_page_load 17:00:10 INFO - PROCESS | 1691 | _x_x_mozilla_page_load_details 17:00:10 INFO - PROCESS | 1691 | |i|pagename|runs| 17:00:10 INFO - PROCESS | 1691 | |0;ai-astar;133;157;163;115;114;133;114;116;115;116 17:00:10 INFO - PROCESS | 1691 | |1;audio-beat-detection;154;127;147;172;152;145;153;120;160;121 17:00:10 INFO - PROCESS | 1691 | |2;audio-dft;226;281;206;244;271;253;199;203;199;200 17:00:10 INFO - PROCESS | 1691 | |3;audio-fft;76;72;75;128;52;68;86;88;68;80 17:00:10 INFO - PROCESS | 1691 | |4;audio-oscillator;85;80;161;122;118;112;119;89;108;146 17:00:10 INFO - PROCESS | 1691 | |5;imaging-gaussian-blur;78;93;86;94;76;79;129;141;86;93 17:00:10 INFO - PROCESS | 1691 | |6;imaging-darkroom;150;105;150;141;153;104;149;150;106;151 17:00:10 INFO - PROCESS | 1691 | |7;imaging-desaturate;146;151;105;149;122;92;126;145;97;92 17:00:10 INFO - PROCESS | 1691 | |8;json-parse-financial;58;58;55;56;58;59;58;65;64;82 17:00:10 INFO - PROCESS | 1691 | |9;json-stringify-tinderbox;67;71;67;72;78;73;71;66;66;70 17:00:10 INFO - PROCESS | 1691 | |10;stanford-crypto-aes;88;84;86;87;100;83;72;103;113;110 17:00:10 INFO - PROCESS | 1691 | |11;stanford-crypto-ccm;126;127;134;133;133;132;127;136;127;123 17:00:10 INFO - PROCESS | 1691 | |12;stanford-crypto-pbkdf2;180;178;140;142;136;147;144;144;164;181 17:00:10 INFO - PROCESS | 1691 | |13;stanford-crypto-sha256-iterative;66;71;69;67;72;67;67;68;66;69 17:00:10 INFO - PROCESS | 1691 | __end_tp_report 17:00:10 INFO - PROCESS | 1691 | __start_cc_report 17:00:10 INFO - PROCESS | 1691 | _x_x_mozilla_cycle_collect,918 17:00:10 INFO - PROCESS | 1691 | __end_cc_report 17:00:10 INFO - PROCESS | 1691 | __startTimestamp1456275610434__endTimestamp 17:00:10 INFO - PROCESS | 1691 | 17:00:10 INFO - PROCESS | 1691 | ------- Summary: start ------- 17:00:10 INFO - PROCESS | 1691 | Number of tests: 14 17:00:10 INFO - PROCESS | 1691 | 17:00:10 INFO - PROCESS | 1691 | [#0] ai-astar Cycles:10 Average:127.60 Median:124.50 stddev:18.66 (15.0%) stddev-sans-first:19.69 17:00:10 INFO - PROCESS | 1691 | Values: 133.0 157.0 163.0 115.0 114.0 133.0 114.0 116.0 115.0 116.0 17:00:10 INFO - PROCESS | 1691 | 17:00:10 INFO - PROCESS | 1691 | [#1] audio-beat-detection Cycles:10 Average:145.10 Median:152.50 stddev:17.25 (11.3%) stddev-sans-first:17.99 17:00:10 INFO - PROCESS | 1691 | Values: 154.0 127.0 147.0 172.0 152.0 145.0 153.0 120.0 160.0 121.0 17:00:10 INFO - PROCESS | 1691 | 17:00:10 INFO - PROCESS | 1691 | [#2] audio-dft Cycles:10 Average:228.20 Median:235.00 stddev:31.83 (13.5%) stddev-sans-first:33.75 17:00:10 INFO - PROCESS | 1691 | Values: 226.0 281.0 206.0 244.0 271.0 253.0 199.0 203.0 199.0 200.0 17:00:10 INFO - PROCESS | 1691 | 17:00:10 INFO - PROCESS | 1691 | [#3] audio-fft Cycles:10 Average:79.30 Median:75.50 stddev:19.93 (26.4%) stddev-sans-first:21.11 17:00:10 INFO - PROCESS | 1691 | Values: 76.0 72.0 75.0 128.0 52.0 68.0 86.0 88.0 68.0 80.0 17:00:10 INFO - PROCESS | 1691 | 17:00:10 INFO - PROCESS | 1691 | [#4] audio-oscillator Cycles:10 Average:114.00 Median:153.50 stddev:25.82 (16.8%) stddev-sans-first:25.16 17:00:10 INFO - PROCESS | 1691 | Values: 85.0 80.0 161.0 122.0 118.0 112.0 119.0 89.0 108.0 146.0 17:00:10 INFO - PROCESS | 1691 | 17:00:10 INFO - PROCESS | 1691 | [#5] imaging-gaussian-blur Cycles:10 Average:95.50 Median:86.00 stddev:21.98 (25.6%) stddev-sans-first:22.38 17:00:10 INFO - PROCESS | 1691 | Values: 78.0 93.0 86.0 94.0 76.0 79.0 129.0 141.0 86.0 93.0 17:00:10 INFO - PROCESS | 1691 | 17:00:10 INFO - PROCESS | 1691 | [#6] imaging-darkroom Cycles:10 Average:135.90 Median:150.00 stddev:21.55 (14.4%) stddev-sans-first:22.25 17:00:10 INFO - PROCESS | 1691 | Values: 150.0 105.0 150.0 141.0 153.0 104.0 149.0 150.0 106.0 151.0 17:00:10 INFO - PROCESS | 1691 | 17:00:10 INFO - PROCESS | 1691 | [#7] imaging-desaturate Cycles:10 Average:122.50 Median:150.00 stddev:24.50 (16.3%) stddev-sans-first:24.47 17:00:10 INFO - PROCESS | 1691 | Values: 146.0 151.0 105.0 149.0 122.0 92.0 126.0 145.0 97.0 92.0 17:00:10 INFO - PROCESS | 1691 | 17:00:10 INFO - PROCESS | 1691 | [#8] json-parse-financial Cycles:10 Average:61.30 Median:58.50 stddev:7.93 (13.6%) stddev-sans-first:8.32 17:00:10 INFO - PROCESS | 1691 | Values: 58.0 58.0 55.0 56.0 58.0 59.0 58.0 65.0 64.0 82.0 17:00:10 INFO - PROCESS | 1691 | 17:00:10 INFO - PROCESS | 1691 | [#9] json-stringify-tinderbox Cycles:10 Average:70.10 Median:71.00 stddev:3.78 (5.3%) stddev-sans-first:3.84 17:00:10 INFO - PROCESS | 1691 | Values: 67.0 71.0 67.0 72.0 78.0 73.0 71.0 66.0 66.0 70.0 17:00:10 INFO - PROCESS | 1691 | 17:00:10 INFO - PROCESS | 1691 | [#10] stanford-crypto-aes Cycles:10 Average:92.60 Median:83.50 stddev:13.20 (15.8%) stddev-sans-first:13.90 17:00:10 INFO - PROCESS | 1691 | Values: 88.0 84.0 86.0 87.0 100.0 83.0 72.0 103.0 113.0 110.0 17:00:10 INFO - PROCESS | 1691 | 17:00:10 INFO - PROCESS | 1691 | [#11] stanford-crypto-ccm Cycles:10 Average:129.80 Median:132.50 stddev:4.29 (3.2%) stddev-sans-first:4.32 17:00:10 INFO - PROCESS | 1691 | Values: 126.0 127.0 134.0 133.0 133.0 132.0 127.0 136.0 127.0 123.0 17:00:10 INFO - PROCESS | 1691 | 17:00:10 INFO - PROCESS | 1691 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.60 Median:155.50 stddev:18.16 (11.7%) stddev-sans-first:16.98 17:00:10 INFO - PROCESS | 1691 | Values: 180.0 178.0 140.0 142.0 136.0 147.0 144.0 144.0 164.0 181.0 17:00:10 INFO - PROCESS | 1691 | 17:00:10 INFO - PROCESS | 1691 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.50 stddev:2.04 (3.0%) stddev-sans-first:2.01 17:00:10 INFO - PROCESS | 1691 | Values: 66.0 71.0 69.0 67.0 72.0 67.0 67.0 68.0 66.0 69.0 17:00:10 INFO - PROCESS | 1691 | -------- Summary: end -------- 17:00:10 INFO - PROCESS | 1691 | 17:00:11 INFO - TEST-INFO | 1691: exit 0 17:00:11 INFO - TEST-OK | kraken | took 59942ms 17:00:11 INFO - SUITE-END | took 1171s 17:00:11 INFO - Completed test suite (00:19:31) 17:00:11 INFO - Working with test: dromaeo_css 17:00:11 INFO - Generating results file: dromaeo_css 17:00:11 INFO - Working with test: kraken 17:00:11 INFO - Generating results file: kraken 17:00:11 INFO - javascript benchmark 17:00:11 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:00:11 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 17:00:11 INFO - process_Request line: dromaeo_css 7456.65 graph.html#tests=[[72,64,61]] 17:00:11 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:00:11 INFO - process_Request line: kraken 1625.70 graph.html#tests=[[232,64,61]] 17:00:11 INFO - RETURN: dromaeo_css: 7456.65 17:00:11 INFO - RETURN: kraken: 1625.70 17:00:11 INFO - javascript benchmark 17:00:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3078.1688943985123, 3310.4703247480393, 3339.71612412945, 3553.662402071804, 3596.4605309203635, 5642.6050176487615, 5647.689377084259, 5687.090065589501, 5701.486866182043, 5719.942800572004, 4429.379886815848, 5709.685967271798, 5741.339745929219, 5745.109508026252, 5831.504322132613, 4405.779711014453, 5159.148740457829, 5198.610104242178, 5212.139996900507, 5334.679919204841, 5220.504052115062, 5270.525652691257, 5274.604404669646, 5289.841304760864, 5305.761240744157, 5145.253938178962, 5220.947790522122, 5250.9737451312885, 5271.393789714193, 5298.629095963265, 5168.974155129238, 5192.0, 5199.584033277329, 5203.505666961632, 5278.287431196816, 4211.368294755781, 5178.818741344035, 5179.093658609729, 5185.611079169077, 5206.921896171561, 5437.8368648940195, 5460.590455715797, 5488.957098151339, 5553.805616803393, 5558.666480011172, 6117.296510901258, 6189.102580125857, 6197.03945888388, 6215.34738852423, 6252.749890004395, 6111.786087486917, 6137.407629318945, 6160.969195154041, 6173.32093469718, 6207.782727604557, 5852.531797456193, 5874.295084589834, 5876.588638795286, 5880.764769409261, 5904.0258357370985, 6135.538906164978, 6245.156903818017, 6316.589421687576, 6325.430711236011, 6332.936670633235, 5653.406392328829, 6158.876822463526, 6183.721732522047, 6184.783532576338, 6215.627062376181, 6182.562259819299, 6221.253449586078, 6229.377062293825, 6245.812625621239, 6257.436830685169, 6088.330283668793, 6125.235451818339, 6201.751929922752, 6245.0320200369015, 6259.843503912439, 6199.28708198563, 6228.377162283736, 6238.376162383725, 6249.093881387264, 6255.874882502416, 4802.543758342952, 4915.016996600622, 4918.754062296871, 4923.606111511071, 4948.678335908155, 3856.749311294813, 4308.159908817751, 4361.367601697736, 4372.366006928977, 4424.358468022118, 5881.176635271066, 5892.882142357129, 5920.378360272195, 5921.73352199152, 5933.881322373529, 4923.655344125877, 6103.701349646901, 6131.3766666500715, 6186.876262474815, 6238.438540531374, 5883.117532370093, 5900.0, 5936.821895343147, 5952.702364881825, 5963.135345374896, 5405.729713514309, 5416.864578385572, 5426.9185962210595, 5429.728513574306, 5440.700761458079, 6248.156498872685, 6319.05214217871, 6364.904526432108, 6403.64779937108, 6411.134496842867, 5305.840824775263, 5463.726813659222, 6115.235595550556, 6189.876202475835, 6251.906221406592, 6073.0, 6240.656763878031, 6396.456301214449, 6402.711877965596, 6416.615003099829, 5103.260027296095, 6117.766507567632, 6241.843953901189, 6243.719032643451, 6268.122462855113, 6176.197094377702, 6178.845528861634, 6195.566310358232, 6207.565470417027, 6215.627062376272, 5349.304590403222, 5436.6194366393975, 6110.984061328523, 6165.907511387422, 6178.196834411678, 6106.179736190777, 6148.231471066117, 6167.629942203482, 6178.073289006685, 6198.566100372931, 5881.235439392852, 5993.0710739835395, 5996.730147143302, 6027.21646185993, 6030.819075427744, 6005.189299444519, 6102.809952059306, 6116.785912493041, 6182.443580077815, 6186.319504854552, 6039.698015099139, 6062.727177277121, 6063.333033366238, 6065.2418447694035, 6084.908726369196], "unit": "score", "name": "dojo.html", "value": 5662.8424697554965}, {"lowerIsBetter": false, "replicates": [469.94595621503515, 520.0846510142151, 524.7428759907647, 595.8421018430117, 612.1368869893452, 38029.80985095074, 38619.613803861954, 38655.0, 38757.80621096894, 38757.99999999996, 38786.80606596963, 39224.41163382552, 39246.8037659812, 39263.41104883429, 39380.40929386061, 9369.43783372998, 9698.272629552777, 9723.319367644268, 9747.658831940884, 9750.658726944559, 9586.808263834719, 9606.0, 9691.563879625433, 9834.360766550188, 9872.407655540655, 9780.364276322016, 9835.967223441507, 9844.310898237127, 9886.456244906527, 9914.305998580103, 9762.658306959258, 9781.266405019653, 9865.950670246675, 9869.259805514579, 9875.259355548327, 9067.68263110788, 9132.99537050924, 9849.704508864745, 9859.556319965619, 9863.556139973718, 37952.43071353932, 38206.617933820584, 38656.80671596652, 38733.80633096817, 38899.52655444632, 3414.0, 3512.631173726773, 3737.2525494900856, 3787.8636409077167, 4029.637332640047, 29503.852480737674, 29702.96039638624, 29728.364939928295, 29851.402971940657, 29918.700812992025, 2761.9171424857286, 2834.985825070882, 2877.4676684813376, 2917.9270518237213, 3005.2637103909465, 390516.0, 473324.0, 479114.0, 479544.0, 480619.0, 45496.09007819825, 46015.53984460179, 46026.84932876705, 46097.53902460999, 46166.76916615463, 44306.55693443089, 44444.77777611091, 44638.55361446409, 44747.88130296769, 44934.876628083905, 15091.01908375952, 15196.240187990556, 15234.771478427832, 15255.542333730005, 15286.312115954808, 12092.395380230953, 12102.878971210352, 12190.57332993341, 12277.631671049883, 12704.3012634306, 12318.445669944875, 14835.887308451693, 14877.628059298388, 14881.925590371979, 14922.403103875724, 6461.127747754087, 6563.113979612786, 6569.868602627921, 6580.440662543738, 6599.0, 969.2585172343163, 971.3491960386558, 1038.5326603028668, 1059.8569193158978, 1119.5689659481159, 27055.458890822072, 32148.83925580357, 32961.83519082437, 33022.0, 33203.50194747081, 1059.9364038157735, 1080.9513571889127, 1119.9832002519968, 1131.4738646529404, 1180.138498895811, 14369.78445323321, 14587.978841480994, 14599.416023358946, 15972.76040859388, 16093.919530402507, 590356.0, 606566.0, 607076.0, 607384.0, 611213.0, 51129.0, 60585.09122363168, 60841.69579152076, 61397.38602614006, 61464.69267653633, 1453.9054961427473, 1455.2650911289732, 1457.1330058614894, 1464.048368560423, 1589.6343840916422, 30908.0, 30944.69055309418, 31045.0, 31462.0, 31623.683763162073, 56065.43934560602, 56293.43706562882, 57021.0, 57072.71463642655, 57224.0, 414296.0, 416221.0, 417463.0, 418130.0, 418720.8127918804, 44325.89185270394, 44519.55480445154, 44525.777371112934, 44883.55116448794, 44916.77541612271, 46270.305945410175, 46368.30447543222, 46869.2969605463, 47421.52578474171, 47559.286610700176, 37933.24133517369, 38373.808130959165, 39091.804540977115, 39269.0, 39307.410388843615, 39733.60266397299, 40118.39822402608, 40227.0, 40722.59277407306, 40839.0, 37466.2506749858, 37473.688420905135, 37661.246775064894, 38634.0, 38750.80624596859, 29583.0, 30479.933202337812, 31140.844295778377, 31857.8407107963, 32157.356852862344, 23811.166609168595, 25013.74986250187, 25246.12661349628, 25275.74724252734, 25579.744202557737], "unit": "score", "name": "ext.html", "value": 19548.718030096064}, {"lowerIsBetter": false, "replicates": [308.5110100490722, 356.0440218014631, 358.50168266110103, 359.7571639143578, 365.85365853658516, 15529.456469023586, 18478.630427391443, 18546.07269636518, 19576.51058723529, 20177.798222017776, 11788.056955443566, 12173.087018473605, 12259.957903578184, 19817.0, 20080.196792128332, 5238.292830467895, 5382.703951282678, 5384.488473595002, 5406.0, 5416.891662166754, 5374.892502149954, 5882.3823498532465, 5942.049272116462, 5943.375945525722, 5947.048472244442, 5789.247397838275, 5834.5915785895, 5874.295084589855, 5910.143029260755, 6182.938170618304, 5926.940730592682, 6096.055111457709, 6131.325554189058, 6131.9386806131815, 6155.353687862777, 5507.449255074501, 5578.107502799533, 5582.162675598652, 5588.916166257469, 5608.018596745594, 13089.934550327283, 13116.803247951288, 13202.66993325165, 13297.202167869958, 13376.0, 2056.331692200041, 2095.8637688550198, 2137.5831712816007, 2539.2255362114547, 2791.623130877326, 8592.754050662681, 8729.0, 9431.669891553762, 9914.25643076765, 13233.0, 1634.1665750467228, 1709.2223038517445, 1753.6492701459758, 1788.5081602559271, 1841.9316796258138, 98982.010179898, 104426.0, 105383.0, 106000.93999060064, 106259.46870265677, 9923.354981926152, 11148.275362101438, 11398.917102875213, 11507.252028618113, 11535.134864885, 11825.88174118265, 12023.0, 13038.348082595832, 13455.192688438725, 13588.59234222975, 8337.333013358917, 8525.573721314033, 8646.956765216259, 8695.347848911357, 8759.912400876037, 8670.653173873101, 8729.956350218208, 8792.384533082623, 8797.208251257418, 8851.734447966572, 3760.8683696070507, 4413.713108647992, 4492.887677808081, 4521.773911304422, 4539.296409056601, 1734.3929624631278, 1844.1701234444554, 1934.458351661537, 1945.8443324534003, 1949.3079956615481, 809.4697972827689, 832.3923535818886, 853.6158728572043, 953.0897992417225, 1044.7910417916446, 19537.316193933144, 20096.296629617893, 20194.990250487415, 20352.796472035385, 20573.971301434867, 928.1646518133733, 940.3840484482674, 978.9902100978899, 998.6554638649654, 1030.0, 10495.370277783357, 10777.245592808427, 10986.780264394667, 10986.835197472044, 11008.614698485675, 279106.60446697637, 280833.0, 281698.0, 355974.0, 596711.0, 111770.0, 115765.0, 116965.0, 118299.0, 119730.20404693937, 858.5878778186506, 880.7093659092484, 1025.707673313117, 1033.6898930320874, 1037.7613148975777, 17509.474715758548, 18158.636827263646, 18260.72608910894, 18800.247990080243, 18847.434576962714, 41138.79430602828, 48206.75896620494, 48543.271850922974, 49371.27200547964, 50267.497325026285, 62454.37545624667, 72742.0, 76336.61831690806, 76589.08527286639, 77527.34835909863, 7909.090454597795, 8006.319462845723, 8161.755147345589, 8292.502449853027, 8347.707830225912, 9261.120193581599, 12914.22514649124, 13662.31688415595, 13686.65783355424, 13696.86303136956, 11132.165087618623, 11430.542778289107, 11549.133814963743, 11590.826137607773, 11744.647660570197, 11181.385023823768, 11211.66365009051, 11285.32288062686, 11343.886561134283, 11591.942040289745, 11396.518452601109, 11611.013063889664, 11981.04151667847, 11997.76004479923, 12067.0, 8073.0, 8251.628676709443, 8257.42198046155, 8311.667533298842, 8355.621322481966, 9495.38280011797, 11880.465379058136, 11895.702607434883, 11930.164888457724, 11989.700257493632], "unit": "score", "name": "jquery.html", "value": 8997.04682343063}, {"lowerIsBetter": false, "replicates": [1555.5799934017816, 1581.3437423469256, 1828.4331857124293, 1926.9518262043448, 1929.093326136717, 7742.341900938427, 8561.443506172094, 8652.653893844246, 8881.955590222047, 9362.01698821624, 7956.124826269106, 8267.966504186976, 8633.0, 8740.475571465717, 8804.20762131408, 2363.58637238483, 2385.7494963028894, 2389.4145934246135, 2395.3652282145244, 2398.5922393193114, 2319.895604697784, 2389.4026493376655, 2449.8407603505716, 2450.3261603059213, 2456.6069428891383, 2145.2598853395552, 2425.987870060656, 2456.5455390752677, 2470.888810003545, 2475.7497463780765, 2424.9151279705125, 2449.448874003353, 2468.6297055441737, 2512.1207577347964, 2515.861627610481, 2486.316263027664, 2504.2362079565723, 2507.736687647789, 2519.596864501671, 2536.7463253674487, 8753.212210900985, 8771.912280877174, 8776.64893404263, 8806.691765788166, 8819.0, 5449.291592093042, 5604.579656525777, 5606.915896261559, 5607.467290607386, 5636.0, 3650.5254316938626, 3666.5416822897137, 3708.9072773180887, 3795.810209489542, 3801.258754542865, 1050.0811789684026, 1058.2486434631421, 1062.1555863088863, 1104.36499013067, 1105.701460605632, 12000.159988800788, 12033.278003319829, 12038.939805301005, 12114.0, 12176.695582610417, 4709.670323077352, 4721.763911804396, 4773.11697335994, 4804.711717296974, 4817.662763606514, 9340.4862732549, 9442.48066356357, 9456.952715236517, 9463.195628371528, 9475.763105922408, 5389.218563308376, 5393.649412788156, 5451.64564303319, 5454.61817672767, 5479.863003424946, 4057.3711074783455, 4461.107778444324, 4931.5315045070665, 4932.161532539477, 4978.950210497921, 3793.0, 3805.1058001369656, 3828.3109040373, 3852.152526444178, 3853.7475320520384, 1034.5654824973378, 1176.2178151529138, 1189.3755778216332, 1194.904407647386, 1196.3300551690907, 1327.6680829792551, 1339.912905661129, 1349.379285528648, 1357.4434481862586, 1368.50733735855, 8181.263686268146, 8261.504309741315, 8293.377996650275, 8306.04480484752, 8345.290650294672, 485.2454433356165, 487.96584239102924, 489.99265011024863, 493.4054464370425, 513.637885290869, 6176.66028368444, 6221.191245138103, 6240.438360547572, 6244.46922011625, 6257.468115210167, 10286.125679317342, 10491.895081049244, 10578.894211057945, 10581.206409519164, 10628.946855265674, 10190.643327483502, 10399.792004159874, 10411.531481083219, 10435.37387756737, 10499.632512862167, 7152.570845749272, 8141.43009989295, 8244.29923456513, 8289.839422480858, 8365.62354694028, 7945.284924356835, 7991.600419979094, 8010.158933311918, 8014.0, 8267.379946504156, 9574.617015319309, 9637.036296370306, 9696.0788725071, 9701.126898579161, 9843.85234221473, 9580.473073980998, 9793.216542676711, 9876.703698888758, 9943.900560994298, 9974.501274936369, 6784.76253331131, 7190.7483238086415, 7426.777196684108, 7456.403487721078, 7529.73645922412, 6905.516613836983, 7019.29807019294, 8185.877211841708, 8245.587720614065, 8247.917520824954, 6724.125863637696, 6732.596044237362, 7311.817204569928, 7358.448116391185, 7494.662740176815, 7269.927300726925, 7279.090113735783, 7305.890411643936, 7306.1963184048645, 7358.080239970004, 7556.622168891643, 7672.6547305372505, 7713.730019449293, 7714.4599878008, 7715.768526944201, 6981.0924579804305, 7043.36609705129, 7069.328413800681, 7071.82320441993, 7080.185778635523, 6427.517936154713, 6875.7937261882225, 7157.284271572801, 7179.1026121734785, 7183.892241616275], "unit": "score", "name": "mootools.html", "value": 4802.01333521384}, {"lowerIsBetter": false, "replicates": [315.9826209558474, 321.8390804597701, 326.03656195941, 326.3635909975548, 329.9076258647578, 6730.427913627335, 6829.385355318021, 6837.145356830396, 6985.825354366143, 7031.578105313684, 6727.562708423949, 6811.523193376465, 6821.113255276807, 6821.9658901705425, 6896.379325860671, 5069.645124841244, 5082.847514574551, 5084.3136176616235, 5086.6693664911845, 5087.058894104584, 5067.974660126694, 5088.974555127219, 5094.006668699605, 5098.821541246057, 5122.436531981479, 5023.346964894558, 5033.842216290255, 5035.496450354972, 5041.067402530525, 5048.5203905628905, 4081.795910204493, 4829.227323628238, 4965.354503914504, 5045.873853153664, 5055.292259083732, 4229.842780182098, 4279.807408666617, 4296.63478604319, 4304.053108316197, 4315.568443155659, 6589.505787065989, 6597.967010164918, 6599.3400659934105, 6628.072069910217, 6647.368499992493, 5627.915581266284, 5840.868083149619, 5849.122631605251, 5875.385453473206, 5896.734646940898, 7243.782686519413, 7247.528910620793, 7253.891191632129, 7267.200607933123, 7286.016387787687, 4592.954070459286, 4612.907741845178, 4616.561426664462, 4621.0, 4623.514530974233, 7748.496347737436, 7839.529628222268, 7846.568438735867, 7851.0186226722235, 7878.330341920886, 4556.954430455653, 4653.930191047137, 4687.671862969628, 4688.296755486636, 4689.015306785614, 4758.381410416624, 4781.043791241766, 4781.593564546983, 4782.33047373361, 4788.784504697297, 4773.331733557305, 5405.8107966221, 5757.309122905278, 5757.88484230313, 5758.1650660654805, 7277.981082648434, 7287.344139027513, 7308.853822923512, 7309.122905251404, 7315.341619254186, 1343.8656134386483, 1654.2886558779599, 1659.8755093368045, 1660.1699150424788, 1666.575023369033, 988.5106872098357, 1027.3527677563088, 1041.9216111324743, 1067.1356201476829, 1086.5708045322212, 6648.0, 6704.698288577026, 6731.663416829237, 6744.966275168691, 6753.594784312957, 7309.0, 7321.121465424183, 7326.047613810277, 7386.0767404074495, 7406.555606663617, 6755.628440435823, 6757.290484499057, 6765.966170169216, 6792.490563207779, 6813.7955861324235, 3171.413288541581, 3681.171736359298, 4011.5988401160234, 4024.8993775155855, 4042.5351084625645, 7905.367570594339, 8044.155363686846, 8103.675852965934, 8108.0, 8137.0, 6359.682015899187, 6603.900941485882, 7677.731279405306, 7937.642806073741, 7963.482373645695, 6350.8412289692205, 8012.959935200403, 8015.198480152055, 8024.839503209903, 8033.517988920684, 7352.338289553966, 7688.423368247292, 7706.152323244327, 7715.881197226483, 7719.691212351668, 6248.968755156195, 7277.490575659653, 7532.284432978859, 7533.660985255787, 7540.547567145989, 8053.154418785943, 8053.838923221386, 8065.83868322642, 8070.0, 8081.515109093473, 4722.291656251589, 4734.905301894012, 4735.147673418817, 4740.644451666208, 4746.288056791509, 7395.593242371721, 7629.6566654499575, 7679.462437629312, 7726.845463090594, 7760.92239077602, 7419.703211871465, 7465.440091993014, 7467.327940485382, 7500.887486687813, 7507.099148102263, 7388.667509961957, 7406.888896666446, 7417.258274172756, 7422.294881986203, 7452.739154129579, 7028.718851245892, 7279.0, 7295.963520182365, 7298.635068246673, 7299.343059124704, 7386.889196662162, 7437.442191835526, 7448.106227252764, 7450.441216908862, 7503.324700776956, 7261.963690181516, 7280.344768970818, 7294.671739771617, 7295.270472952662, 7308.780736577911], "unit": "score", "name": "prototype.html", "value": 5305.50341745489}, {"lowerIsBetter": false, "replicates": [601.1553766957425, 661.5005670718607, 699.8506719761075, 711.7544447165726, 731.4514114414189, 14199.432022719104, 14979.325930333134, 15194.848051519495, 15236.1620110894, 15493.992890462141, 13507.324633768321, 15343.232838358093, 15473.845261547382, 15496.535103946899, 15497.992630479011, 841.8316336732647, 848.1476116502906, 857.5069335132292, 858.4891989266376, 859.8710193470966, 836.1178956201205, 844.1474111147724, 846.1411667157839, 847.737201467544, 848.7835601921502, 886.2998231397221, 892.0499667853747, 892.0811564088999, 895.5208963204686, 901.0268909577674, 879.1604018162672, 881.088073843572, 886.1714297132202, 892.2861710631469, 893.9016708162097, 554.9833504994857, 655.3806652713188, 662.483263054818, 672.4922683374022, 675.1729131813538, 14899.851001489955, 14972.850271497255, 15059.472918447802, 15091.24543772807, 15147.621309467242, 12103.878961210363, 12149.392530373534, 12242.204256723373, 12538.68653283666, 12600.117991740583, 9962.750931226778, 9987.500624968796, 10084.042016008467, 10133.277342851732, 10143.543540540693, 3304.6695330467, 3341.6992470677515, 3402.0644322811177, 3426.4860270959557, 3532.8410221540094, 72781.27218727798, 73382.63308683422, 83098.58450707707, 83896.0, 83978.16021839765, 9307.72076837696, 9315.813683726288, 9322.440653560809, 9360.251179905592, 9621.615135394506, 20602.690959635616, 20644.277450289166, 20784.48038799042, 20788.688169677465, 20862.687059694115, 7326.0, 7332.670029848669, 7458.813529661693, 7603.0, 7718.151003389623, 4097.610726980932, 4134.836368690351, 4136.793160341971, 4212.978935105305, 4326.913461730748, 3452.637473065292, 3474.42671959129, 3474.8783792567137, 3475.3570589441033, 3481.112316359312, 517.4799326676666, 611.8837420890017, 618.8267285160073, 633.7369991453495, 646.0083771410862, 565.3922033813667, 588.7262422973338, 597.8505373656586, 624.4202168513667, 631.4727202785725, 6818.28408017151, 7940.205979402129, 8360.790980225422, 8521.147885211429, 9089.681861134828, 538.4185080113468, 585.1544518171287, 602.9879402411927, 606.9362716914749, 621.3910367839543, 3967.0, 3980.800959951991, 4046.3728122141115, 4056.59434056592, 4146.360949109209, 65552.0, 81262.59368703119, 90344.0, 90776.09223907809, 90837.54581227184, 64869.35130648633, 65712.75728805852, 75801.24198757941, 76761.61619191869, 76996.61501692455, 60728.0, 61473.38526614677, 64341.678291608245, 66037.66981165063, 68543.0, 8788.384813063025, 8806.64773409082, 8874.169562677771, 8994.280457563249, 9013.459192448474, 46064.8483787908, 46393.376231831724, 47107.0, 47289.52710472851, 48528.54414367575, 57530.42469575251, 62478.37521624907, 67869.0, 68041.63916721736, 68653.0, 10630.0, 10691.732706682395, 10822.296550724177, 10889.397376072813, 11530.308181509135, 11803.23278986863, 11811.940940295244, 11813.291202527877, 12044.337561434206, 12332.383380831103, 10850.94574527154, 11390.772184556428, 11442.0, 11633.429487019144, 11756.58851940178, 11001.504932278227, 11613.477393517482, 11635.47640356169, 11653.475593598478, 12231.816522751988, 11072.169587280825, 11370.488328025092, 11407.771844563229, 11446.771064578828, 11987.580434684744, 9349.53252337394, 9545.665901693408, 9737.707868763948, 9829.459379734184, 10209.540570674486, 8162.0613629431, 8686.652533898574, 9565.952170239105, 9872.605095796087, 9899.851502227617], "unit": "score", "name": "yui.html", "value": 6773.687461729575}], "name": "dromaeo_css", "value": 7456.648378926059}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [133.0, 157.0, 163.0, 115.0, 114.0, 133.0, 114.0, 116.0, 115.0, 116.0], "unit": "score", "name": "ai-astar", "value": 127.6}, {"lowerIsBetter": true, "replicates": [154.0, 127.0, 147.0, 172.0, 152.0, 145.0, 153.0, 120.0, 160.0, 121.0], "unit": "score", "name": "audio-beat-detection", "value": 145.1}, {"lowerIsBetter": true, "replicates": [226.0, 281.0, 206.0, 244.0, 271.0, 253.0, 199.0, 203.0, 199.0, 200.0], "unit": "score", "name": "audio-dft", "value": 228.2}, {"lowerIsBetter": true, "replicates": [76.0, 72.0, 75.0, 128.0, 52.0, 68.0, 86.0, 88.0, 68.0, 80.0], "unit": "score", "name": "audio-fft", "value": 79.3}, {"lowerIsBetter": true, "replicates": [85.0, 80.0, 161.0, 122.0, 118.0, 112.0, 119.0, 89.0, 108.0, 146.0], "unit": "score", "name": "audio-oscillator", "value": 114.0}, {"lowerIsBetter": true, "replicates": [78.0, 93.0, 86.0, 94.0, 76.0, 79.0, 129.0, 141.0, 86.0, 93.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 95.5}, {"lowerIsBetter": true, "replicates": [150.0, 105.0, 150.0, 141.0, 153.0, 104.0, 149.0, 150.0, 106.0, 151.0], "unit": "score", "name": "imaging-darkroom", "value": 135.9}, {"lowerIsBetter": true, "replicates": [146.0, 151.0, 105.0, 149.0, 122.0, 92.0, 126.0, 145.0, 97.0, 92.0], "unit": "score", "name": "imaging-desaturate", "value": 122.5}, {"lowerIsBetter": true, "replicates": [58.0, 58.0, 55.0, 56.0, 58.0, 59.0, 58.0, 65.0, 64.0, 82.0], "unit": "score", "name": "json-parse-financial", "value": 61.3}, {"lowerIsBetter": true, "replicates": [67.0, 71.0, 67.0, 72.0, 78.0, 73.0, 71.0, 66.0, 66.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 70.1}, {"lowerIsBetter": true, "replicates": [88.0, 84.0, 86.0, 87.0, 100.0, 83.0, 72.0, 103.0, 113.0, 110.0], "unit": "score", "name": "stanford-crypto-aes", "value": 92.6}, {"lowerIsBetter": true, "replicates": [126.0, 127.0, 134.0, 133.0, 133.0, 132.0, 127.0, 136.0, 127.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 129.8}, {"lowerIsBetter": true, "replicates": [180.0, 178.0, 140.0, 142.0, 136.0, 147.0, 144.0, 144.0, 164.0, 181.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 155.6}, {"lowerIsBetter": true, "replicates": [66.0, 71.0, 69.0, 67.0, 72.0, 67.0, 67.0, 68.0, 66.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.2}], "name": "kraken", "value": 1625.6999999999996}]} 17:00:11 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1625.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7456.65"}}} 17:00:11 INFO - Return code: 0 17:00:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:00:11 ERROR - # TBPL SUCCESS # 17:00:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:00:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:00:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:00:11 INFO - 2016-02-23 17:00:11.854 screenresolution[1696:10236] starting screenresolution argv=screenresolution get 17:00:11 INFO - 2016-02-23 17:00:11.857 screenresolution[1696:10236] Display 0: 1600x1200x32@60 17:00:11 INFO - 2016-02-23 17:00:11.863 screenresolution[1697:10239] starting screenresolution argv=screenresolution list 17:00:11 INFO - Available Modes on Display 0 17:00:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:00:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:00:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:00:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:00:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:00:12 INFO - Intel Iris: 17:00:12 INFO - Chipset Model: Intel Iris 17:00:12 INFO - Type: GPU 17:00:12 INFO - Bus: Built-In 17:00:12 INFO - VRAM (Dynamic, Max): 1536 MB 17:00:12 INFO - Vendor: Intel (0x8086) 17:00:12 INFO - Device ID: 0x0a2e 17:00:12 INFO - Revision ID: 0x0009 17:00:12 INFO - Displays: 17:00:12 INFO - Display: 17:00:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:00:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:00:12 INFO - Display Serial Number: 1600x1200 60 17:00:12 INFO - Main Display: Yes 17:00:12 INFO - Mirror: Off 17:00:12 INFO - Online: Yes 17:00:12 INFO - Rotation: Supported 17:00:12 INFO - Return code: 0 17:00:12 INFO - Running post-action listener: _resource_record_post_action 17:00:12 INFO - Running post-run listener: _resource_record_post_run 17:00:13 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 39372288; Write bytes: 710085120; Read time: 423; Write time: 1945 17:00:13 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 395366912; Write bytes: 389330944; Read time: 29950; Write time: 676 17:00:13 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 37553664; Write bytes: 302903808; Read time: 403; Write time: 1230 17:00:13 INFO - Running post-run listener: _upload_blobber_files 17:00:13 INFO - Blob upload gear active. 17:00:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:00:13 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:00:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:00:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:00:13 INFO - (blobuploader) - INFO - Open directory for files ... 17:00:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:00:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:00:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:00:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:00:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:00:14 INFO - (blobuploader) - INFO - Done attempting. 17:00:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:00:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:00:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:00:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:00:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:00:15 INFO - (blobuploader) - INFO - Done attempting. 17:00:15 INFO - (blobuploader) - INFO - Iteration through files over. 17:00:15 INFO - Return code: 0 17:00:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:00:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:00:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5141ac32cce798ebc081ed53ddb54cb7776e6dffa2c6c6efa5cd34321e8a4ad3deca87cf894561fef81a79c4a1479f83dbeb9b6e3afb5503a799026b47257803", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d637c3b2a9705b7df4e4ccb5a09e02930b81df9aa7783a42aba94755eafaa2b6d8353cc78b2f66ea1607439f28f229ba0cc85aa5e58df327dcdd48296bf35487"} 17:00:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:00:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:00:15 INFO - Contents: 17:00:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5141ac32cce798ebc081ed53ddb54cb7776e6dffa2c6c6efa5cd34321e8a4ad3deca87cf894561fef81a79c4a1479f83dbeb9b6e3afb5503a799026b47257803", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d637c3b2a9705b7df4e4ccb5a09e02930b81df9aa7783a42aba94755eafaa2b6d8353cc78b2f66ea1607439f28f229ba0cc85aa5e58df327dcdd48296bf35487"} 17:00:15 INFO - Running post-run listener: copy_logs_to_upload_dir 17:00:15 INFO - Copying logs to upload dir... 17:00:15 INFO - mkdir: /builds/slave/test/build/upload/logs 17:00:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.794614 ========= master_lag: 0.71 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-02-23 17:00:16.381502) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-23 17:00:16.383890) ========= 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.2XIKlUP7ec/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.WcVVfVnPUq/Listeners TMPDIR=/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5141ac32cce798ebc081ed53ddb54cb7776e6dffa2c6c6efa5cd34321e8a4ad3deca87cf894561fef81a79c4a1479f83dbeb9b6e3afb5503a799026b47257803", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d637c3b2a9705b7df4e4ccb5a09e02930b81df9aa7783a42aba94755eafaa2b6d8353cc78b2f66ea1607439f28f229ba0cc85aa5e58df327dcdd48296bf35487"} build_url:https://queue.taskcluster.net/v1/task/Xou6s2awTtGEdQ3-fH3PpA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011842 build_url: 'https://queue.taskcluster.net/v1/task/Xou6s2awTtGEdQ3-fH3PpA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5141ac32cce798ebc081ed53ddb54cb7776e6dffa2c6c6efa5cd34321e8a4ad3deca87cf894561fef81a79c4a1479f83dbeb9b6e3afb5503a799026b47257803", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d637c3b2a9705b7df4e4ccb5a09e02930b81df9aa7783a42aba94755eafaa2b6d8353cc78b2f66ea1607439f28f229ba0cc85aa5e58df327dcdd48296bf35487"}' ========= master_lag: 0.62 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-23 17:00:17.015883) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 17:00:17.016244) ========= 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.2XIKlUP7ec/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.WcVVfVnPUq/Listeners TMPDIR=/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005306 ========= master_lag: 0.16 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 17:00:17.177993) ========= ========= Started reboot skipped (results: 3, elapsed: 2 secs) (at 2016-02-23 17:00:17.178352) ========= ========= Finished reboot skipped (results: 3, elapsed: 2 secs) (at 2016-02-23 17:00:19.882645) ========= ========= Total master_lag: 1.68 =========