builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0131 starttime: 1455582961.5 results: success (0) buildid: 20160215154449 builduid: eae0ab7acdc24740a977e74d98b875f8 revision: b2d75ac5ba0fc90ab7e58e81caff2e4b474f7ca9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-15 16:36:01.501096) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-15 16:36:01.501602) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-15 16:36:01.501936) ========= 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.wxYbj8eaYE/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.vFBr68d91O/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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.005550 basedir: '/builds/slave/test' ========= master_lag: 0.07 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-15 16:36:01.576165) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-15 16:36:01.576543) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-15 16:36:01.803160) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 16:36:01.803514) ========= 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.wxYbj8eaYE/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.vFBr68d91O/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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.005717 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 16:36:01.896062) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-15 16:36:01.896406) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-15 16:36:01.896881) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 16:36:01.897441) ========= 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.wxYbj8eaYE/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.vFBr68d91O/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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-15 16:36:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.5M=0.001s 2016-02-15 16:36:02 (15.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.155476 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 16:36:02.104846) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 16:36:02.105181) ========= 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.wxYbj8eaYE/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.vFBr68d91O/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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.027410 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 16:36:02.162113) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 16:36:02.162521) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b2d75ac5ba0fc90ab7e58e81caff2e4b474f7ca9 --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 b2d75ac5ba0fc90ab7e58e81caff2e4b474f7ca9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wxYbj8eaYE/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.vFBr68d91O/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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-15 16:36:02,226 truncating revision to first 12 chars 2016-02-15 16:36:02,226 Setting DEBUG logging. 2016-02-15 16:36:02,226 attempt 1/10 2016-02-15 16:36:02,226 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b2d75ac5ba0f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-15 16:36:02,873 unpacking tar archive at: fx-team-b2d75ac5ba0f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.884156 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 16:36:03.064522) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-15 16:36:03.064880) ========= echo b2d75ac5ba0fc90ab7e58e81caff2e4b474f7ca9 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'b2d75ac5ba0fc90ab7e58e81caff2e4b474f7ca9'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wxYbj8eaYE/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.vFBr68d91O/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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 b2d75ac5ba0fc90ab7e58e81caff2e4b474f7ca9 program finished with exit code 0 elapsedTime=0.005757 script_repo_revision: 'b2d75ac5ba0fc90ab7e58e81caff2e4b474f7ca9' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-15 16:36:03.116176) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-15 16:36:03.116541) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-15 16:36:03.137959) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 38 secs) (at 2016-02-15 16:36:03.138257) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wxYbj8eaYE/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.vFBr68d91O/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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:36:03 INFO - MultiFileLogger online at 20160215 16:36:03 in /builds/slave/test 16:36:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 16:36:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:36:03 INFO - {'append_to_log': False, 16:36:03 INFO - 'base_work_dir': '/builds/slave/test', 16:36:03 INFO - 'blob_upload_branch': 'Fx-Team', 16:36:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:36:03 INFO - 'branch': 'Fx-Team', 16:36:03 INFO - 'buildbot_json_path': 'buildprops.json', 16:36:03 INFO - 'config_files': ('talos/mac_config.py',), 16:36:03 INFO - 'default_actions': ('clobber', 16:36:03 INFO - 'read-buildbot-config', 16:36:03 INFO - 'download-and-extract', 16:36:03 INFO - 'populate-webroot', 16:36:03 INFO - 'create-virtualenv', 16:36:03 INFO - 'install', 16:36:03 INFO - 'run-tests'), 16:36:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:36:03 INFO - 'download_minidump_stackwalk': True, 16:36:03 INFO - 'download_symbols': 'ondemand', 16:36:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:36:03 INFO - 'tooltool.py': '/tools/tooltool.py', 16:36:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:36:03 INFO - '/tools/misc-python/virtualenv.py')}, 16:36:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:36:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:36:03 INFO - 'installer_path': 'installer.exe', 16:36:03 INFO - 'log_level': 'info', 16:36:03 INFO - 'log_name': 'talos', 16:36:03 INFO - 'log_to_console': True, 16:36:03 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:36:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:36:03 INFO - 'opt_config_files': (), 16:36:03 INFO - 'pip_index': False, 16:36:03 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:36:03 INFO - 'cmd': ('bash', 16:36:03 INFO - '-c', 16:36:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:36:03 INFO - 'enabled': True, 16:36:03 INFO - 'halt_on_failure': False, 16:36:03 INFO - 'name': 'check_screen_resolution'},), 16:36:03 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:36:03 INFO - 'cmd': ('bash', 16:36:03 INFO - '-c', 16:36:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:36:03 INFO - 'enabled': True, 16:36:03 INFO - 'halt_on_failure': False, 16:36:03 INFO - 'name': 'check_screen_resolution'},), 16:36:03 INFO - 'run_cmd_checks_enabled': True, 16:36:03 INFO - 'sps_profile': False, 16:36:03 INFO - 'sps_profile_interval': 0, 16:36:03 INFO - 'suite': 'dromaeojs', 16:36:03 INFO - 'system_bits': '32', 16:36:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:36:03 INFO - 'title': 't-yosemite-r7-0131', 16:36:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:36:03 INFO - 'use_talos_json': True, 16:36:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:36:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:36:03 INFO - 'work_dir': 'build'} 16:36:03 INFO - ##### 16:36:03 INFO - ##### Running clobber step. 16:36:03 INFO - ##### 16:36:03 INFO - Running pre-action listener: _resource_record_pre_action 16:36:03 INFO - Running main action method: clobber 16:36:03 INFO - rmtree: /builds/slave/test/build 16:36:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:36:04 INFO - Running post-action listener: _resource_record_post_action 16:36:04 INFO - ##### 16:36:04 INFO - ##### Running read-buildbot-config step. 16:36:04 INFO - ##### 16:36:04 INFO - Running pre-action listener: _resource_record_pre_action 16:36:04 INFO - Running main action method: read_buildbot_config 16:36:04 INFO - Using buildbot properties: 16:36:04 INFO - { 16:36:04 INFO - "project": "", 16:36:04 INFO - "product": "firefox", 16:36:04 INFO - "script_repo_revision": "production", 16:36:04 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 16:36:04 INFO - "repository": "", 16:36:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 16:36:04 INFO - "buildid": "20160215154449", 16:36:04 INFO - "pgo_build": "False", 16:36:04 INFO - "basedir": "/builds/slave/test", 16:36:04 INFO - "buildnumber": 443, 16:36:04 INFO - "slavename": "t-yosemite-r7-0131", 16:36:04 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 16:36:04 INFO - "platform": "yosemite_r7", 16:36:04 INFO - "scheduler": "tests-fx-team-macosx64-talos", 16:36:04 INFO - "branch": "fx-team", 16:36:04 INFO - "repo_path": "integration/fx-team", 16:36:04 INFO - "revision": "b2d75ac5ba0fc90ab7e58e81caff2e4b474f7ca9", 16:36:04 INFO - "stage_platform": "macosx64", 16:36:04 INFO - "builduid": "eae0ab7acdc24740a977e74d98b875f8", 16:36:04 INFO - "slavebuilddir": "test" 16:36:04 INFO - } 16:36:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/B_mrhWg7TwCluTaeHAsmCg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 16:36:04 INFO - Running post-action listener: _resource_record_post_action 16:36:04 INFO - ##### 16:36:04 INFO - ##### Running download-and-extract step. 16:36:04 INFO - ##### 16:36:04 INFO - Running pre-action listener: _resource_record_pre_action 16:36:04 INFO - Running main action method: download_and_extract 16:36:04 INFO - mkdir: /builds/slave/test/build/tests 16:36:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:04 INFO - https://queue.taskcluster.net/v1/task/B_mrhWg7TwCluTaeHAsmCg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:36:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_mrhWg7TwCluTaeHAsmCg/artifacts/public/build/test_packages.json 16:36:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_mrhWg7TwCluTaeHAsmCg/artifacts/public/build/test_packages.json 16:36:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_mrhWg7TwCluTaeHAsmCg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 16:36:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_mrhWg7TwCluTaeHAsmCg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 16:36:28 INFO - Downloaded 1277 bytes. 16:36:28 INFO - Reading from file /builds/slave/test/build/test_packages.json 16:36:28 INFO - Using the following test package requirements: 16:36:28 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 16:36:28 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:36:28 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 16:36:28 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:36:28 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 16:36:28 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:36:28 INFO - u'jsshell-mac.zip'], 16:36:28 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:36:28 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 16:36:28 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 16:36:28 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:36:28 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 16:36:28 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:36:28 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 16:36:28 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:36:28 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 16:36:28 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 16:36:28 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:36:28 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 16:36:28 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:36:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:28 INFO - https://queue.taskcluster.net/v1/task/B_mrhWg7TwCluTaeHAsmCg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:36:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_mrhWg7TwCluTaeHAsmCg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 16:36:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_mrhWg7TwCluTaeHAsmCg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 16:36:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_mrhWg7TwCluTaeHAsmCg/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:36:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_mrhWg7TwCluTaeHAsmCg/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:36:33 INFO - Downloaded 17802713 bytes. 16:36:33 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:36:33 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:36:36 INFO - Return code: 0 16:36:36 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:36:36 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:36:36 INFO - https://queue.taskcluster.net/v1/task/B_mrhWg7TwCluTaeHAsmCg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:36:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_mrhWg7TwCluTaeHAsmCg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 16:36:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_mrhWg7TwCluTaeHAsmCg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 16:36:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_mrhWg7TwCluTaeHAsmCg/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:36:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_mrhWg7TwCluTaeHAsmCg/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:36:47 INFO - Downloaded 17802713 bytes. 16:36:47 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:36:47 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:36:50 INFO - Return code: 0 16:36: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:36:50 INFO - https://queue.taskcluster.net/v1/task/B_mrhWg7TwCluTaeHAsmCg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 16:36:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_mrhWg7TwCluTaeHAsmCg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 16:36:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_mrhWg7TwCluTaeHAsmCg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 16:36:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_mrhWg7TwCluTaeHAsmCg/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:36:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_mrhWg7TwCluTaeHAsmCg/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:36:51 INFO - Downloaded 10707070 bytes. 16:36:51 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:36:51 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:36:51 INFO - Return code: 0 16:36:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:51 INFO - https://queue.taskcluster.net/v1/task/B_mrhWg7TwCluTaeHAsmCg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 16:36:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_mrhWg7TwCluTaeHAsmCg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 16:36:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_mrhWg7TwCluTaeHAsmCg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 16:36:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_mrhWg7TwCluTaeHAsmCg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 16:36:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_mrhWg7TwCluTaeHAsmCg/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:36:54 INFO - Downloaded 111144859 bytes. 16:36:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/B_mrhWg7TwCluTaeHAsmCg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 16:36:54 INFO - mkdir: /builds/slave/test/properties 16:36:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:36:54 INFO - Writing to file /builds/slave/test/properties/build_url 16:36:54 INFO - Contents: 16:36:54 INFO - build_url:https://queue.taskcluster.net/v1/task/B_mrhWg7TwCluTaeHAsmCg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 16:36:55 INFO - Running post-action listener: _resource_record_post_action 16:36:55 INFO - Running post-action listener: set_extra_try_arguments 16:36:55 INFO - ##### 16:36:55 INFO - ##### Running populate-webroot step. 16:36:55 INFO - ##### 16:36:55 INFO - Running pre-action listener: _resource_record_pre_action 16:36:55 INFO - Running main action method: populate_webroot 16:36:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:36:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:36:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:36:55 INFO - '--tppagecycles', 16:36:55 INFO - '7'], 16:36:55 INFO - 'tests': ['tsvgm']}}, 16:36:55 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:36:55 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:36:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:36:55 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:36:55 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:36:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:36:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:36:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:55 INFO - 'talos_options': ['--e10s'], 16:36:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:36:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:55 INFO - 'tests': ['damp', 'tps']}, 16:36:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:55 INFO - 'talos_options': ['--e10s'], 16:36:55 INFO - 'tests': ['damp', 'tps']}, 16:36:55 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:36:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:36:55 INFO - 'other': {'tests': ['a11yr', 16:36:55 INFO - 'ts_paint', 16:36:55 INFO - 'tpaint', 16:36:55 INFO - 'sessionrestore', 16:36:55 INFO - 'sessionrestore_no_auto_restore']}, 16:36:55 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:36:55 INFO - 'tests': ['a11yr', 16:36:55 INFO - 'ts_paint', 16:36:55 INFO - 'tpaint', 16:36:55 INFO - 'sessionrestore', 16:36:55 INFO - 'sessionrestore_no_auto_restore']}, 16:36:55 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:36:55 INFO - 'tests': ['a11yr', 16:36:55 INFO - 'ts_paint', 16:36:55 INFO - 'tpaint', 16:36:55 INFO - 'sessionrestore', 16:36:55 INFO - 'sessionrestore_no_auto_restore']}, 16:36:55 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:36:55 INFO - 'tests': ['a11yr', 16:36:55 INFO - 'ts_paint', 16:36:55 INFO - 'tpaint', 16:36:55 INFO - 'sessionrestore', 16:36:55 INFO - 'sessionrestore_no_auto_restore']}, 16:36:55 INFO - 'other_l64': {'tests': ['a11yr', 16:36:55 INFO - 'ts_paint', 16:36:55 INFO - 'tpaint', 16:36:55 INFO - 'sessionrestore', 16:36:55 INFO - 'sessionrestore_no_auto_restore']}, 16:36:55 INFO - 'other_nol64': {'tests': ['a11yr', 16:36:55 INFO - 'ts_paint', 16:36:55 INFO - 'tpaint', 16:36:55 INFO - 'sessionrestore', 16:36:55 INFO - 'sessionrestore_no_auto_restore']}, 16:36:55 INFO - 'svgr': {'tests': ['tsvgx', 16:36:55 INFO - 'tsvgr_opacity', 16:36:55 INFO - 'tart', 16:36:55 INFO - 'tscrollx', 16:36:55 INFO - 'cart']}, 16:36:55 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:36:55 INFO - 'tests': ['tsvgx', 16:36:55 INFO - 'tsvgr_opacity', 16:36:55 INFO - 'tart', 16:36:55 INFO - 'tscrollx', 16:36:55 INFO - 'cart']}, 16:36:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:55 INFO - 'tests': ['tp5o']}, 16:36:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:55 INFO - 'talos_options': ['--e10s'], 16:36:55 INFO - 'tests': ['tp5o']}, 16:36:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:55 INFO - 'talos_options': ['--xperf_path', 16:36:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:36:55 INFO - 'tests': ['tp5n']}, 16:36:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:55 INFO - 'talos_options': ['--e10s', 16:36:55 INFO - '--xperf_path', 16:36:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:36:55 INFO - 'tests': ['tp5n']}}, 16:36:55 INFO - 'talos.zip': {'path': '', 16:36:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:36:55 INFO - Running post-action listener: _resource_record_post_action 16:36:55 INFO - ##### 16:36:55 INFO - ##### Running create-virtualenv step. 16:36:55 INFO - ##### 16:36:55 INFO - Running pre-action listener: _resource_record_pre_action 16:36:55 INFO - Running main action method: create_virtualenv 16:36:55 INFO - Creating virtualenv /builds/slave/test/build/venv 16:36:55 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:36:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:36:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:36:55 INFO - Using real prefix '/tools/python27' 16:36:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:36:56 INFO - Installing distribute.............................................................................................................................................................................................done. 16:36:59 INFO - Installing pip.................done. 16:36:59 INFO - Return code: 0 16:36:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:36: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:36:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36: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:36:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f95ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9644c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95cacbaaf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f800d30>, '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 0x10f624db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7f7b20>, '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.wxYbj8eaYE/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.vFBr68d91O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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:36: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', 'pip>=1.5'] in /builds/slave/test/build 16:36: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 pip>=1.5 16:36:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wxYbj8eaYE/Render', 16:36:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:36:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:36:59 INFO - 'HOME': '/Users/cltbld', 16:36:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:36:59 INFO - 'LOGNAME': 'cltbld', 16:36:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:59 INFO - 'MOZ_NO_REMOTE': '1', 16:36:59 INFO - 'NO_EM_RESTART': '1', 16:36:59 INFO - 'PAGER': '/bin/cat', 16:36:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:36:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:59 INFO - 'PWD': '/builds/slave/test', 16:36:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:36:59 INFO - 'SHELL': '/bin/bash', 16:36:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vFBr68d91O/Listeners', 16:36:59 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 16:36:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:36:59 INFO - 'USER': 'cltbld', 16:36:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:36:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:36:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:59 INFO - 'XPC_FLAGS': '0x0', 16:36:59 INFO - 'XPC_SERVICE_NAME': '0', 16:36:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:36:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:59 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:36:59 INFO - Cleaning up... 16:36:59 INFO - Return code: 0 16:36:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:36: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:36:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36: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:36:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36: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', '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 0x10f95ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9644c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95cacbaaf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f800d30>, '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 0x10f624db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7f7b20>, '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.wxYbj8eaYE/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.vFBr68d91O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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:36: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', 'psutil>=0.7.1'] in /builds/slave/test/build 16:36: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 psutil>=0.7.1 16:36:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wxYbj8eaYE/Render', 16:36:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:36:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:36:59 INFO - 'HOME': '/Users/cltbld', 16:36:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:36:59 INFO - 'LOGNAME': 'cltbld', 16:36:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:59 INFO - 'MOZ_NO_REMOTE': '1', 16:36:59 INFO - 'NO_EM_RESTART': '1', 16:36:59 INFO - 'PAGER': '/bin/cat', 16:36:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:36:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:59 INFO - 'PWD': '/builds/slave/test', 16:36:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:36:59 INFO - 'SHELL': '/bin/bash', 16:36:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vFBr68d91O/Listeners', 16:36:59 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 16:36:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:36:59 INFO - 'USER': 'cltbld', 16:36:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:36:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:36:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:59 INFO - 'XPC_FLAGS': '0x0', 16:36:59 INFO - 'XPC_SERVICE_NAME': '0', 16:36:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:37:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:00 INFO - Downloading/unpacking psutil>=0.7.1 16:37:00 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:37:00 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:37:00 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:37:00 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:37:00 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:37:00 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:37:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:37:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:37:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:37:03 INFO - Installing collected packages: psutil 16:37:03 INFO - Running setup.py install for psutil 16:37:03 INFO - building 'psutil._psutil_osx' extension 16:37:03 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 16:37:03 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 16:37:03 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 16:37:03 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 16:37:03 INFO - building 'psutil._psutil_posix' extension 16:37:03 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 16:37:04 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:37:04 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:37:04 INFO - ^ 16:37:04 INFO - 1 warning generated. 16:37:04 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:37:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:37:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:37:04 INFO - Successfully installed psutil 16:37:04 INFO - Cleaning up... 16:37:04 INFO - Return code: 0 16:37:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:37:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:04 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 0x10f95ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9644c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95cacbaaf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f800d30>, '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 0x10f624db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7f7b20>, '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.wxYbj8eaYE/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.vFBr68d91O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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:37:04 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:37:04 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:37:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wxYbj8eaYE/Render', 16:37:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:37:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:37:04 INFO - 'HOME': '/Users/cltbld', 16:37:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:37:04 INFO - 'LOGNAME': 'cltbld', 16:37:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:04 INFO - 'MOZ_NO_REMOTE': '1', 16:37:04 INFO - 'NO_EM_RESTART': '1', 16:37:04 INFO - 'PAGER': '/bin/cat', 16:37:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:37:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:04 INFO - 'PWD': '/builds/slave/test', 16:37:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:37:04 INFO - 'SHELL': '/bin/bash', 16:37:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vFBr68d91O/Listeners', 16:37:04 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 16:37:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:37:04 INFO - 'USER': 'cltbld', 16:37:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:37:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:37:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:04 INFO - 'XPC_FLAGS': '0x0', 16:37:04 INFO - 'XPC_SERVICE_NAME': '0', 16:37:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:37:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:37:04 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:37:04 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:37:04 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:37:04 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:37:04 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:37:04 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:37:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:37:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:37:06 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:37:06 INFO - Installing collected packages: mozsystemmonitor 16:37:06 INFO - Running setup.py install for mozsystemmonitor 16:37:07 INFO - Successfully installed mozsystemmonitor 16:37:07 INFO - Cleaning up... 16:37:07 INFO - Return code: 0 16:37:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:37:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f95ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9644c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95cacbaaf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f800d30>, '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 0x10f624db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7f7b20>, '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.wxYbj8eaYE/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.vFBr68d91O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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:37:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:37:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:37:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wxYbj8eaYE/Render', 16:37:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:37:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:37:07 INFO - 'HOME': '/Users/cltbld', 16:37:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:37:07 INFO - 'LOGNAME': 'cltbld', 16:37:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:07 INFO - 'MOZ_NO_REMOTE': '1', 16:37:07 INFO - 'NO_EM_RESTART': '1', 16:37:07 INFO - 'PAGER': '/bin/cat', 16:37:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:37:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:07 INFO - 'PWD': '/builds/slave/test', 16:37:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:37:07 INFO - 'SHELL': '/bin/bash', 16:37:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vFBr68d91O/Listeners', 16:37:07 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 16:37:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:37:07 INFO - 'USER': 'cltbld', 16:37:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:37:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:37:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:07 INFO - 'XPC_FLAGS': '0x0', 16:37:07 INFO - 'XPC_SERVICE_NAME': '0', 16:37:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:37:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:07 INFO - Downloading/unpacking blobuploader==1.2.4 16:37:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:10 INFO - Downloading blobuploader-1.2.4.tar.gz 16:37:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:37:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:37:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:37:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:37:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:11 INFO - Downloading docopt-0.6.1.tar.gz 16:37:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:37:11 INFO - Installing collected packages: blobuploader, requests, docopt 16:37:11 INFO - Running setup.py install for blobuploader 16:37:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:37:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:37:11 INFO - Running setup.py install for requests 16:37:12 INFO - Running setup.py install for docopt 16:37:12 INFO - Successfully installed blobuploader requests docopt 16:37:12 INFO - Cleaning up... 16:37:12 INFO - Return code: 0 16:37:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:37:12 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:37:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:12 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:37:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:12 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 0x10f95ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9644c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95cacbaaf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f800d30>, '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 0x10f624db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7f7b20>, '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.wxYbj8eaYE/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.vFBr68d91O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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:37:12 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:37:12 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:37:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wxYbj8eaYE/Render', 16:37:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:37:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:37:12 INFO - 'HOME': '/Users/cltbld', 16:37:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:37:12 INFO - 'LOGNAME': 'cltbld', 16:37:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:12 INFO - 'MOZ_NO_REMOTE': '1', 16:37:12 INFO - 'NO_EM_RESTART': '1', 16:37:12 INFO - 'PAGER': '/bin/cat', 16:37:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:37:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:12 INFO - 'PWD': '/builds/slave/test', 16:37:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:37:12 INFO - 'SHELL': '/bin/bash', 16:37:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vFBr68d91O/Listeners', 16:37:12 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 16:37:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:37:12 INFO - 'USER': 'cltbld', 16:37:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:37:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:37:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:12 INFO - 'XPC_FLAGS': '0x0', 16:37:12 INFO - 'XPC_SERVICE_NAME': '0', 16:37:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:37:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:37:12 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-A2duqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:37:12 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-JBWxj7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:37:12 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-6v7pgr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:37:12 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-b3WP2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:37:12 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-omi_NQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:37:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:37:13 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-1CGWbh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:37:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:37:13 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-BYy5Sp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:37:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:37:13 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-qvU1Hq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:37:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:37:13 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-6TcfFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:37:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:37:13 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-ZON7QV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:37:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:37:13 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-RHjDa7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:37:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:37:13 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-5bNOsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:37:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:37:13 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-5tE_qQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:37:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:37:13 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-HF5_xZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:37:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:37:13 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-c0TjHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:37:14 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-PrFbH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:37:14 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-OSLBV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:37:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:37:14 INFO - Running setup.py install for manifestparser 16:37:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:37:14 INFO - Running setup.py install for mozcrash 16:37:14 INFO - Running setup.py install for mozdebug 16:37:14 INFO - Running setup.py install for mozdevice 16:37:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:37:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:37:14 INFO - Running setup.py install for mozfile 16:37:15 INFO - Running setup.py install for mozhttpd 16:37:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:37:15 INFO - Running setup.py install for mozinfo 16:37:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:37:15 INFO - Running setup.py install for mozInstall 16:37:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:37:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:37:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:37:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:37:15 INFO - Running setup.py install for mozleak 16:37:15 INFO - Running setup.py install for mozlog 16:37:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:37:15 INFO - Running setup.py install for moznetwork 16:37:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:37:15 INFO - Running setup.py install for mozprocess 16:37:16 INFO - Running setup.py install for mozprofile 16:37:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:37:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:37:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:37:16 INFO - Running setup.py install for mozrunner 16:37:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:37:16 INFO - Running setup.py install for mozscreenshot 16:37:16 INFO - Running setup.py install for moztest 16:37:16 INFO - Running setup.py install for mozversion 16:37:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:37:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:37:16 INFO - Cleaning up... 16:37:16 INFO - Return code: 0 16:37:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:37:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f95ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9644c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95cacbaaf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f800d30>, '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 0x10f624db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7f7b20>, '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.wxYbj8eaYE/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.vFBr68d91O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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:37:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:37:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:37:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wxYbj8eaYE/Render', 16:37:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:37:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:37:16 INFO - 'HOME': '/Users/cltbld', 16:37:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:37:16 INFO - 'LOGNAME': 'cltbld', 16:37:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:16 INFO - 'MOZ_NO_REMOTE': '1', 16:37:16 INFO - 'NO_EM_RESTART': '1', 16:37:16 INFO - 'PAGER': '/bin/cat', 16:37:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:37:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:16 INFO - 'PWD': '/builds/slave/test', 16:37:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:37:16 INFO - 'SHELL': '/bin/bash', 16:37:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vFBr68d91O/Listeners', 16:37:16 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 16:37:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:37:16 INFO - 'USER': 'cltbld', 16:37:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:37:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:37:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:16 INFO - 'XPC_FLAGS': '0x0', 16:37:16 INFO - 'XPC_SERVICE_NAME': '0', 16:37:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:37:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:37:17 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-R5D4OU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:37:17 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:37:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:37:17 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-QMxukG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:37:17 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:37:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:37:17 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-Vbxv4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:37:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:37:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:37:17 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-Lt6r8h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:37:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:37:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:37:17 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-Qz7L16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:37:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:37:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:37:17 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-yuYeGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:37:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:37:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:37:17 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-pUMe1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:37:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:37:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:37:17 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-Uw2lBi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:37:18 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:37:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:37:18 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-M2EOEO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:37:18 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:37:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:37:18 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-oYbZm6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:37:18 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:37:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:37:18 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-Gevq9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:37:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:37:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:37:18 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-Z585tG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:37:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:37:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:37:18 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-y_QGDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:37:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:37:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:37:18 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-M8MA00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:37:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:37:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:37:18 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-OM3HTD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:37:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:37:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:37:18 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-5ov3ia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:37:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:37:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:37:18 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-8DFRbK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:37:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:37:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:37:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:37:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:37:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:37:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:37:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:37:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:21 INFO - Downloading blessings-1.6.tar.gz 16:37:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:37:21 INFO - Installing collected packages: blessings 16:37:21 INFO - Running setup.py install for blessings 16:37:21 INFO - Successfully installed blessings 16:37:21 INFO - Cleaning up... 16:37:21 INFO - Return code: 0 16:37:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:37:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:37:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:37:21 INFO - Reading from file tmpfile_stdout 16:37:21 INFO - Current package versions: 16:37:21 INFO - blessings == 1.6 16:37:21 INFO - blobuploader == 1.2.4 16:37:21 INFO - docopt == 0.6.1 16:37:21 INFO - manifestparser == 1.1 16:37:21 INFO - mozInstall == 1.12 16:37:21 INFO - mozcrash == 0.16 16:37:21 INFO - mozdebug == 0.1 16:37:21 INFO - mozdevice == 0.48 16:37:21 INFO - mozfile == 1.2 16:37:21 INFO - mozhttpd == 0.7 16:37:21 INFO - mozinfo == 0.9 16:37:21 INFO - mozleak == 0.1 16:37:21 INFO - mozlog == 3.1 16:37:21 INFO - moznetwork == 0.27 16:37:21 INFO - mozprocess == 0.22 16:37:21 INFO - mozprofile == 0.28 16:37:21 INFO - mozrunner == 6.11 16:37:21 INFO - mozscreenshot == 0.1 16:37:21 INFO - mozsystemmonitor == 0.0 16:37:21 INFO - moztest == 0.7 16:37:21 INFO - mozversion == 1.4 16:37:21 INFO - psutil == 3.1.1 16:37:21 INFO - requests == 1.2.3 16:37:21 INFO - wsgiref == 0.1.2 16:37:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:37:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f95ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9644c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95cacbaaf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f800d30>, '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 0x10f624db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7f7b20>, '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.wxYbj8eaYE/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.vFBr68d91O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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:37:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:37:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:37:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wxYbj8eaYE/Render', 16:37:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:37:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:37:21 INFO - 'HOME': '/Users/cltbld', 16:37:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:37:21 INFO - 'LOGNAME': 'cltbld', 16:37:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:21 INFO - 'MOZ_NO_REMOTE': '1', 16:37:21 INFO - 'NO_EM_RESTART': '1', 16:37:21 INFO - 'PAGER': '/bin/cat', 16:37:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:37:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:21 INFO - 'PWD': '/builds/slave/test', 16:37:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:37:21 INFO - 'SHELL': '/bin/bash', 16:37:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vFBr68d91O/Listeners', 16:37:21 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 16:37:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:37:21 INFO - 'USER': 'cltbld', 16:37:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:37:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:37:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:21 INFO - 'XPC_FLAGS': '0x0', 16:37:21 INFO - 'XPC_SERVICE_NAME': '0', 16:37:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:37:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:22 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:37:22 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:37:22 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:37:22 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:37:22 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:37:22 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:37:22 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:37:22 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:37:22 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:37:22 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:37:22 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:37:22 INFO - Cleaning up... 16:37:22 INFO - Return code: 0 16:37:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:37:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f95ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9644c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95cacbaaf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f800d30>, '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 0x10f624db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7f7b20>, '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.wxYbj8eaYE/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.vFBr68d91O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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:37:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:37:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:37:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wxYbj8eaYE/Render', 16:37:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:37:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:37:22 INFO - 'HOME': '/Users/cltbld', 16:37:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:37:22 INFO - 'LOGNAME': 'cltbld', 16:37:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:22 INFO - 'MOZ_NO_REMOTE': '1', 16:37:22 INFO - 'NO_EM_RESTART': '1', 16:37:22 INFO - 'PAGER': '/bin/cat', 16:37:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:37:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:22 INFO - 'PWD': '/builds/slave/test', 16:37:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:37:22 INFO - 'SHELL': '/bin/bash', 16:37:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vFBr68d91O/Listeners', 16:37:22 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 16:37:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:37:22 INFO - 'USER': 'cltbld', 16:37:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:37:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:37:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:22 INFO - 'XPC_FLAGS': '0x0', 16:37:22 INFO - 'XPC_SERVICE_NAME': '0', 16:37:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:37:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:22 INFO - Downloading/unpacking jsonschema 16:37:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:37:24 INFO - Downloading/unpacking functools32 (from jsonschema) 16:37:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:25 INFO - Downloading functools32-3.2.3-2.tar.gz 16:37:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:37:25 INFO - warning: no files found matching '*.txt' 16:37:25 INFO - no previously-included directories found matching 'build' 16:37:25 INFO - no previously-included directories found matching 'dist' 16:37:25 INFO - no previously-included directories found matching '.git*' 16:37:25 INFO - Installing collected packages: jsonschema, functools32 16:37:25 INFO - Running setup.py install for functools32 16:37:25 INFO - warning: no files found matching '*.txt' 16:37:25 INFO - no previously-included directories found matching 'build' 16:37:25 INFO - no previously-included directories found matching 'dist' 16:37:25 INFO - no previously-included directories found matching '.git*' 16:37:25 INFO - Successfully installed jsonschema functools32 16:37:25 INFO - Cleaning up... 16:37:25 INFO - Return code: 0 16:37:25 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:37: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:37:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37: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:37:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f95ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9644c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95cacbaaf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f800d30>, '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 0x10f624db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7f7b20>, '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.wxYbj8eaYE/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.vFBr68d91O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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:37:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 16:37:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:37:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wxYbj8eaYE/Render', 16:37:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:37:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:37:25 INFO - 'HOME': '/Users/cltbld', 16:37:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:37:25 INFO - 'LOGNAME': 'cltbld', 16:37:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:25 INFO - 'MOZ_NO_REMOTE': '1', 16:37:25 INFO - 'NO_EM_RESTART': '1', 16:37:25 INFO - 'PAGER': '/bin/cat', 16:37:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:37:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:25 INFO - 'PWD': '/builds/slave/test', 16:37:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:37:25 INFO - 'SHELL': '/bin/bash', 16:37:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vFBr68d91O/Listeners', 16:37:25 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 16:37:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:37:25 INFO - 'USER': 'cltbld', 16:37:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:37:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:37:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:25 INFO - 'XPC_FLAGS': '0x0', 16:37:25 INFO - 'XPC_SERVICE_NAME': '0', 16:37:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:37:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:25 INFO - Downloading/unpacking flake8 16:37:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:37:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:37:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:37:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:37:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:37:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:37:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:37:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:37:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:37:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:37:29 INFO - no previously-included directories found matching 'docs/_build' 16:37:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:37:29 INFO - Running setup.py install for pep8 16:37:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:37:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:37:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:37:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:37:29 INFO - no previously-included directories found matching 'docs/_build' 16:37:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:37:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:37:29 INFO - Cleaning up... 16:37:29 INFO - Return code: 0 16:37:29 INFO - Running post-action listener: _resource_record_post_action 16:37:29 INFO - Running post-action listener: _start_resource_monitoring 16:37:29 INFO - Starting resource monitoring. 16:37:29 INFO - ##### 16:37:29 INFO - ##### Running install step. 16:37:29 INFO - ##### 16:37:29 INFO - Running pre-action listener: _resource_record_pre_action 16:37:29 INFO - Running main action method: install 16:37:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:37:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:37:30 INFO - Reading from file tmpfile_stdout 16:37:30 INFO - Detecting whether we're running mozinstall >=1.0... 16:37:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:37:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:37:30 INFO - Reading from file tmpfile_stdout 16:37:30 INFO - Output received: 16:37:30 INFO - Usage: mozinstall [options] installer 16:37:30 INFO - Options: 16:37:30 INFO - -h, --help show this help message and exit 16:37:30 INFO - -d DEST, --destination=DEST 16:37:30 INFO - Directory to install application into. [default: 16:37:30 INFO - "/builds/slave/test"] 16:37:30 INFO - --app=APP Application being installed. [default: firefox] 16:37:30 INFO - mkdir: /builds/slave/test/build/application 16:37:30 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:37:30 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:38:03 INFO - Reading from file tmpfile_stdout 16:38:03 INFO - Output received: 16:38:03 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:38:03 INFO - Running post-action listener: _resource_record_post_action 16:38:03 INFO - ##### 16:38:03 INFO - ##### Running run-tests step. 16:38:03 INFO - ##### 16:38:03 INFO - Running pre-action listener: _resource_record_pre_action 16:38:03 INFO - Running main action method: run_tests 16:38:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:38:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:38:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:38:03 INFO - 2016-02-15 16:38:03.880 screenresolution[1669:11648] starting screenresolution argv=screenresolution get 16:38:03 INFO - 2016-02-15 16:38:03.882 screenresolution[1669:11648] Display 0: 1600x1200x32@60 16:38:03 INFO - 2016-02-15 16:38:03.887 screenresolution[1670:11650] starting screenresolution argv=screenresolution list 16:38:03 INFO - Available Modes on Display 0 16:38:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:38:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:38:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:38:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:38:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:38:04 INFO - Intel Iris: 16:38:04 INFO - Chipset Model: Intel Iris 16:38:04 INFO - Type: GPU 16:38:04 INFO - Bus: Built-In 16:38:04 INFO - VRAM (Dynamic, Max): 1536 MB 16:38:04 INFO - Vendor: Intel (0x8086) 16:38:04 INFO - Device ID: 0x0a2e 16:38:04 INFO - Revision ID: 0x0009 16:38:04 INFO - Displays: 16:38:04 INFO - Display: 16:38:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:38:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:38:04 INFO - Display Serial Number: 1600x1200 60 16:38:04 INFO - Main Display: Yes 16:38:04 INFO - Mirror: Off 16:38:04 INFO - Online: Yes 16:38:04 INFO - Rotation: Supported 16:38:04 INFO - Return code: 0 16:38:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:38:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:38:04 INFO - Python 2.7.3 16:38:04 INFO - Return code: 0 16:38:04 INFO - grabbing minidump binary from tooltool 16:38:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:04 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f800d30>, '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 0x10f624db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7f7b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:38:04 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:38:04 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 16:38:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:38:04 INFO - Return code: 0 16:38:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:38:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:38:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:38:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:38:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:38:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:38:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:38:05 INFO - Return code: 0 16:38:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B_mrhWg7TwCluTaeHAsmCg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0131', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 16:38:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/B_mrhWg7TwCluTaeHAsmCg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0131 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 16:38:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wxYbj8eaYE/Render', 16:38:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:38:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:38:05 INFO - 'HOME': '/Users/cltbld', 16:38:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:38:05 INFO - 'LOGNAME': 'cltbld', 16:38:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:38:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:38:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:05 INFO - 'MOZ_NO_REMOTE': '1', 16:38:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:38:05 INFO - 'NO_EM_RESTART': '1', 16:38:05 INFO - 'PAGER': '/bin/cat', 16:38:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:38:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:05 INFO - 'PWD': '/builds/slave/test', 16:38:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:38:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:38:05 INFO - 'SHELL': '/bin/bash', 16:38:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vFBr68d91O/Listeners', 16:38:05 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 16:38:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:38:05 INFO - 'USER': 'cltbld', 16:38:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:38:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:38:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:05 INFO - 'XPC_FLAGS': '0x0', 16:38:05 INFO - 'XPC_SERVICE_NAME': '0', 16:38:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:38:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B_mrhWg7TwCluTaeHAsmCg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0131', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:38:05 INFO - mozversion application_buildid: 20160215154449 16:38:05 INFO - mozversion application_changeset: b2d75ac5ba0fc90ab7e58e81caff2e4b474f7ca9 16:38:05 INFO - mozversion application_display_name: Nightly 16:38:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:38:05 INFO - mozversion application_name: Firefox 16:38:05 INFO - mozversion application_remotingname: firefox 16:38:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:38:05 INFO - mozversion application_vendor: Mozilla 16:38:05 INFO - mozversion application_version: 47.0a1 16:38:05 INFO - mozversion platform_buildid: 20160215154449 16:38:05 INFO - mozversion platform_changeset: b2d75ac5ba0fc90ab7e58e81caff2e4b474f7ca9 16:38:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:38:05 INFO - mozversion platform_version: 47.0a1 16:38:05 INFO - using testdate: 1455583085 16:38:05 INFO - actual date: 1455583085 16:38:06 INFO - starting webserver on 'localhost:49274' 16:38:06 INFO - SUITE-START | Running 2 tests 16:38:06 INFO - TEST-START | dromaeo_css 16:38:06 INFO - operating with platform_type : mac_ 16:38:06 INFO - Initialising browser for dromaeo_css test... 16:38:06 INFO - TEST-INFO | started process 1688 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/tmpbmsPXp/profile http://localhost:49274/getInfo.html) 16:38:08 INFO - PROCESS | 1688 | __metrics Screen width/height:1600/1200 16:38:08 INFO - PROCESS | 1688 | colorDepth:24 16:38:08 INFO - PROCESS | 1688 | Browser inner width/height: 1024/689 16:38:08 INFO - PROCESS | 1688 | __metrics 16:38:08 INFO - PROCESS | 1688 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:38:08 INFO - PROCESS | 1688 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:38:09 INFO - TEST-INFO | 1688: exit 0 16:38:09 INFO - Browser initialized. 16:38:09 INFO - Running cycle 1/1 for dromaeo_css test... 16:38:09 INFO - TEST-INFO | started process 1692 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/tmpbmsPXp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:38:21 INFO - PROCESS | 1692 | RSS: Main: 245657600 16:38:21 INFO - PROCESS | 1692 | 16:39:12 INFO - PROCESS | 1692 | 1455583152381 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:41:23 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 16:41:24 INFO - PROCESS | 1692 | RSS: Main: 404574208 16:41:24 INFO - PROCESS | 1692 | 16:44:27 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 16:44:28 INFO - PROCESS | 1692 | RSS: Main: 381124608 16:44:28 INFO - PROCESS | 1692 | 16:47:30 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 16:47:30 INFO - PROCESS | 1692 | RSS: Main: 380944384 16:47:30 INFO - PROCESS | 1692 | 16:50:32 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 16:50:33 INFO - PROCESS | 1692 | RSS: Main: 337719296 16:50:33 INFO - PROCESS | 1692 | 16:53:36 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 16:53:37 INFO - PROCESS | 1692 | RSS: Main: 341475328 16:53:37 INFO - PROCESS | 1692 | 16:56:39 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 16:56:40 INFO - PROCESS | 1692 | RSS: Main: 435236864 16:56:40 INFO - PROCESS | 1692 | 16:56:40 INFO - PROCESS | 1692 | __start_tp_report 16:56:40 INFO - PROCESS | 1692 | _x_x_mozilla_page_load 16:56:40 INFO - PROCESS | 1692 | _x_x_mozilla_page_load_details 16:56:40 INFO - PROCESS | 1692 | |i|pagename|runs| 16:56:40 INFO - PROCESS | 1692 | |0;dojo.html;3422.726181905447;3480.164760457491;3499.897532277334;3514.648535146485;3550.4141816600263;5637.182608521772;5701.344345400275;5705.572082093844;5714.971425142874;5724.427557244274;4380.496242932056;5618.775248990036;5757.827265182052;5881.235439392884;5891.705414729267;5125;5169.121249387613;5181.481851814826;5197.558207552363;5269.604779641523;5265.420803711589;5274.789008439677;5291.708956007418;5296.867578310554;5334.093204155283;5148.639595228336;5153;5250.816221432251;5255.106631872591;5275.340582427197;5230.372355317386;5247.501487358695;5261.026710058613;5285.207218917155;5296.390915044781;5083.212102124176;5182.041322355376;5205;5206.0368831766245;5242.370915490127;5556.91664625031;5685.459881311269;5707.857303567403;5723.255976723041;5775.16260142277;6201.224846894138;6207.255129384503;6217.658028808413;6221.160143380631;6231.875362492725;6085.117657939618;6262.968685156545;6273.717682704244;6277.811665650038;6278.560500764948;5828.0966450200285;5859.267591551056;5876.118582212703;5940.673262970535;5941.405859414067;6279.0895320178315;6287.49700023997;6291.307956124822;6291.370862913672;6310.558260921692;6059.757609695563;6061.418801126416;6116.244470650255;6201.317855035943;6213.65824879636;6250.3749625037135;6304;6305.211848518935;6317.4946004319545;6329.778457753957;6216.658083805343;6263.091851681572;6271.62370257786;6274.843128921813;6287.717052732638;5971.313298970587;6001.459868611846;6072.878542429126;6089.421504957022;6274.968625156845;4879.975600122048;4899.265110233494;4912.828051018198;4914.680545764514;4920.975395123001;4379.540148284448;4405.074934263776;4477.194105061055;4481.910361792746;4481.910361792811;5570.888582228333;5614.775408983676;5624.100143976944;5646;5734.77060917567;6183.350748171467;6310.7475700971445;6320.494360451153;6331.96834015827;6334.651594162366;5648.435156484401;5650.63270887391;5663.631863928831;5666.15007748841;5686.3744988051285;5300.787968481295;5382.381026182039;5388.703621300866;5390.110631745796;5396.1366181410785;6268.843278918063;6283.403076707706;6326.936730632727;6346.365363463617;6352.872942541216;6292.842678933063;6297.559170857996;6306.558540902093;6321.936780632319;6339.492840572835;6176.66028368444;6264.310925798068;6294.339094395023;6323.588966717149;6325.525585581192;6118.9846826261555;6247.187865577446;6264.060390941395;6269.655168965751;6272.121902933502;6255.906161407674;6289.056641503811;6302.495800335871;6309.684515774101;6312.873742525032;5990.520758339235;6124.479419249414;6126.540509461897;6132.540059495466;6171.382861713792;6120.660465672032;6123.313124872426;6131.4990048534;6133.73253493014;6136.978641397139;5973.104034394875;5975.193348898017;5993.280806303272;5994.0409534474275;6271.184745983175;5941.643501389931;6085.300190478151;6088.452039316483;6102.420270074336;6122.908156377569;5920.763169473345;5953.6725480097275;5955;5957.225560677084;5959.821205363846 16:56:40 INFO - PROCESS | 1692 | |1;ext.html;460.5923757474634;467.9298105284207;517.0279873837187;526.9671443969819;565.6634302589957;29496.26259343515;29951.850240748794;37483;37849.86450406492;37959;38709.225815483675;38974.61025389745;38988.41517377242;39015.41476877849;39038;9444.622215111387;9679.854802177973;9683.322167448281;9691.806163876718;9697.224222062217;9547.904520954806;9702;9713;9715.125638692516;9718.902810971906;9085.273178145733;9341.95329023354;9800.16698580618;9900.90099099007;9908.504574771268;9741.512924353789;9752.658656946973;9774.853377199348;9809.362391444605;9830.655927042591;9454.716358509255;9600.95199524005;9604.90395096047;9605.231581473536;9629.807403851953;38384;39066;39099.218015639526;39111.21777564433;39263.01842453933;3299.653536378694;3448.258624395767;3672.5042119313816;3686.705063594906;3695.2791412267297;27680.723192768015;28367.43265134686;28483.715162848315;28525.28686782826;28573.714262857313;2788.7490125888567;2823.816451930618;2856.22881821909;2892.681805001448;2971.2126286534085;458976.70511647564;460567;460989;461326;461566.69216654036;53108.734456328246;54202;60672.39327606756;61134;61495.38504614986;49404;59594.51013724605;59984;60364.09453858196;60515;15770.684586308209;15978;16003.119828409317;16028.95811772231;16041.358345666276;10164.796704065877;11429;11585.6524304271;12355.32045737493;12550.623481295575;14327.713445731028;18657;18735.718964215546;18766.53083672919;18804;7783.80540486481;7801.219878012267;8061.556614386265;8065.153158918347;8106.473079249948;855.8074433252468;939.8120375924842;992.9106380425652;1019.3883669798211;1034.9793004139874;29432.411351772844;29490.410191796043;29741;30194.54708179379;30238;1032.7211652853687;1037.3620223562605;1048.156234231451;1050.3540322701483;1143.5311522275993;12764.106512544218;12816.974642028616;12830.615081547568;12848.550300739429;13355.46578136883;509312;526578.3671081697;526902;527006;529444;53912;54241.91516169733;54252.45747542474;54285.45714542804;54413.72793136009;1415.0872687116753;1431.141315210886;1444.978325325142;1447.4789075932867;1458.6134674311315;23579.174728884405;27260.454790903674;27914;27962.580561292005;29455;35165.296694066485;43461.565384345755;50454.747726261136;50503;50570.74714626551;352002;354933;355131;355245;355285;27631.894724210808;28069.43861122807;28314.009009684563;29037.41925161443;29913.551296730133;39314.80342598383;41803;42400.78799605982;42569.361459577514;42640.57359426366;34386.31227375389;35509.82245088758;35688.82155589206;36101;36106.63893361033;35599.92615986361;35852;35991.64008359988;36034.4594831083;36068;34280;35221.29557408889;35395.93812185639;35480;35491.82254088713;29306;31686.68313316837;31689;31726.524102138024;31727.36545269128;24529.386765331008;24546.87726561356;24552.33542475835;24658.01367945334;24775.876120619283 16:56:40 INFO - PROCESS | 1692 | |2;jquery.html;324.2606856367482;360.41792505104246;364.25146324303563;366.67732395491964;369.62483079674155;15001.549953501413;15472.613184670388;19115.52211194719;20058.297959571417;20589.176432942702;18791.932887382376;18820.811791882075;19387.32144374947;19394.93327866967;19735.309264175758;4888.5600295973445;5565.443455654443;5615.129654903497;5616.9157462638095;5621.016322143629;4047.433359329696;4273.764942928137;5597.104463285875;5642.463965923252;5963.194968679238;6094;6129.662868542228;6164.568480206387;6168.0439531872635;6176.8455788605415;5998.8800223995495;6171.753129874822;6172.938270617304;6176.227971503562;6183.9381606183815;5146.330976973007;5257.08001099806;5305.814296499604;5307;5312.654677445954;23860.89808324924;23971.640425393634;24116.758832411626;24514.754852451602;24680.25959221208;2040.6938959156098;2181.6727490876337;2542.733013033623;2593.832775251126;2891.8698658560415;6509.479241660656;12134.757304853942;13935.651608709763;14229.644258893506;14333.140011599233;1684.983150168507;1751.5971326594827;1768.3810666266832;1783.4382169616529;1791.7401976713434;90074;92518.53740731321;92615.07384926132;93088.06911930862;94179.52910235473;8216.835663286702;10404.479776011169;10573.418461984511;10606.204534659932;10688.358698478116;12542.435590398454;12700.555480558136;12702.682432939066;12713.237205767684;12713.618591442086;8475.957620211859;8492.575371231414;8538.487690738575;8604.268637165911;8635.093315201939;8834.64661413549;8838.955805220932;8856.025837157908;8932.330075244383;8934.374593778502;6078.574499785061;6162.938370616326;6166.630002199882;6175.876482470326;6181.350958149419;1644.629958259382;1707.6413953069994;1734.6357264974497;1741.6777896089263;1802.12596890508;891.1177933845446;892.5225004622625;935.6912218967724;957.1194501059042;1022.9028242316969;14977.176255305845;19157.521061973563;19436.61126777485;19768.209271628974;19962;855.8972923249125;981.8379967305315;1005.4520286443906;1038.065740833256;1054.8681414823147;10836.620718274822;11119.666410007712;11154.944225278983;11191.888081119085;11231.10151187903;514686;659226;660616;695040;710366.4481677559;59592.404075958686;62074.75850482965;92408.07591923994;94782;96184;1001.4191768774239;1042.551702767802;1141.5559317463415;1142.9771404572027;1169.3393232823428;17553.210105545535;17821.73267401016;17896.194671239566;17998.91000544989;18302.26790928401;32525.512117317787;40635.79682101689;44975.775121124185;45092.54907450883;47397.34109306158;68622;68834;69831.65084174546;71220.64389678018;71396.64301678458;6982.231954485104;7366.079240094989;7463.701451941862;7529.887051694339;7567.9243207569425;10487.52806123711;11667.824982625438;11811.586594469152;11880.386315010684;12015.939920300343;6831.590104593542;9335.533223338942;9438.914524829457;10565.313254638424;10691.358518488916;8526.019507756688;8749.343799214957;10046.598136074475;10050.89949100529;10362.171026317727;9484.956654768108;9821.803563928825;10269.332493387907;10736.570537178426;10794.73013174677;7295.270472952874;7468.850622987401;7507;7543.43424243173;7619.314261716472;6737.393634572912;8670.479771213748;10295.845562316721;10448.164146868081;10469.476526173814 16:56:40 INFO - PROCESS | 1692 | |3;mootools.html;1288.5812111063906;1484.8366679665235;1515.8105236845395;1745.9039752813599;1857.6656201883657;8041.316488098511;8646.17861303176;8824.8676269856;8828.205461508463;8849.159329863669;8559.486430814155;8835.779105522364;8838.381313308071;8841.867371989425;8868.645254189842;2180.5093853882827;2242.7981481666648;2426.5389575980594;2496.2885577610386;2523.5457617628817;2482.466269752012;2502.637117617944;2514.88683009265;2517.773400393964;2518.106072344319;2447.339218411028;2486.105002199216;2491.862947537885;2497.887595058227;2502.9749702503013;2414.553307638084;2495.301315631626;2495.4759500505006;2496.113879572744;2499.8375105618074;2457.3242358351595;2488.639147323646;2508.4481414088873;2508.5610018246734;2513.7611926866916;8921.821563568757;8976.23701985332;9002.369834111614;9005.639774409081;9013.36906416551;5398.2982212312545;5539.446055394468;5576.7211639417865;5577.8605534861545;5600.187972743929;3148.2286839724416;3200.807951522893;3525.1363415962996;3849.9807500962315;3861.6717579005817;1047.3768107975743;1053.5259133390005;1064.978700425995;1100.757833276678;1101.6639924822925;12286;12302.323372214525;12333.198342107824;12338.321392323418;12356.814647780291;4929.285253638202;4959.876003099879;4977.776000080005;5022.723750193702;5050.4697006814495;10412.947935260276;10426.68719938403;10438.008389203014;10452.738681533023;10470.581176752998;5604.6917419541505;5608.523275521545;5612.887742245214;5613.46672066153;5615.466530679579;4962.379702537183;5102.591792656579;5103.387593488805;5107.514786095315;5112.233165025202;3682.5580930288;3787.659110680052;3919.2161567686576;3959.4852669152824;4011.4785077940264;1142.2575326037975;1274.5347947998914;1311.9409626566828;1326.0187461278776;1328.4088580581742;1305.7845455499926;1322.8544860065385;1328.3424704771007;1349.6625843539116;1353.3842101843638;8127.59362031896;8164.836703265902;8186.918130818734;8188.344932405513;8198.38512111594;1172.4313707851686;1192.469351138735;1192.8628207756046;1199.1366216324232;1216.4100411300512;6255.280642726145;6263.874722505524;6342.968285158637;6345.650989195638;6353.936460635427;10640.414777187329;11086.778264434666;11098.889011109946;11099.001089901947;11116.61091861781;10482.63310784119;10787.730306742395;10896.782064358827;10904.291221070605;10929.672109836718;8409.705660301861;8421.410501264974;8503.61733721984;8514.957425212835;8515.659373624985;7747.30274275318;7905.169957154646;7972.800679983046;7986.241307075818;8005.799855003672;9452.810943781224;9824.557894894604;9886.30795844284;9915.355501892354;9939.155171810187;9854.260930430102;10133.391996480235;10243.026912443305;10313.535890885078;10336.17310615164;6779.796606101825;7506.211847755907;7554.131274903457;7555.017847679766;7645.120811106572;6236.282827474898;7707.884381734167;8255.587220639065;8257.669693212205;8269.586520673822;7563.357114645317;7764.961175194087;7781.2218778124;7797.337226335825;7892.881606776018;7530.510516816389;7559.357454616199;7581.355584775356;7658.081030276402;7699.191584883507;6335.588186767845;7786.805329866798;7796.883046754417;7805.946197263297;7904.881426778718;7020.964895175492;7050.506464547432;7086.893696594659;7094.006839042435;7106.111736032996;6062.242219722535;7256.9274307256255;7270.745523906638;7271.054762880792;7273.927260727325 16:56:40 INFO - PROCESS | 1692 | |4;prototype.html;314.8598873501292;322.07885447619805;323.61328212785725;328.949012903;330.0083249834251;6146.539009574278;6574.605523668577;6592.670366481669;6596.076549283098;6610.834729131774;6418.646974416405;6548.410643042125;6549.607023578588;6549.934500654992;6565.113709649196;4053.2501487224886;4901.142300097486;4913.943502147038;4920.7785649645675;4922.458529561745;4759.976200118995;4884.291777692232;4892.706437613737;4914.508549145093;4927.531884470987;4825.131476334259;4831.106245344605;4837.201861692816;4851.199552073904;4878.560929516343;4622.560856718606;4748.501407352247;4863.927041094369;4872.512748725135;4892.510748925115;3683.797391143486;4111.773852438115;4123.195976784528;4125.711200215986;4133.503979522477;6236.563440559163;6270.118964310735;6313.273973493061;6316.9368306317265;6326.9683651581445;5389.434109418533;5494.2582751328855;5584.106542953108;5666;5682.51698605619;5836.212111364954;6811.284815094443;6882.793516194472;6908.689108990107;6914.239433662293;4652.697574657636;4655.022445286494;4658.208104622222;4660.650451216138;4667.766611669403;5966.791162309299;7073.610951397671;7402.888956665654;7416.480846340704;7419;4768.3085952536685;4769.785359658824;4772.976135119302;4774.3793306870575;4778.617710583145;3993.3011722948368;4048.4534587830267;4838.975805120952;4853.39332583427;4855.223164293696;5699.800506982318;5704.372519022904;5711.600187986801;5715.142728590745;5718.914216286759;6757.255226454835;7025.367716905503;7059.71761129549;7060.293970602898;7074.575525468488;1662.783838101039;1681.327469012405;1683.2677785163494;1684.991575042117;1685.612309168898;1070.9518071686794;1086.5056399338282;1096.1504833753904;1103.3049179017169;1104.3870651788175;6462.547621666438;6480.31956644555;6492.740290388331;6508.056331831858;6509.056186852879;7237.6019318936915;7245.710171593078;7257.419406447471;7266.92733072673;7269.818254543678;6273.749050038039;6471.126397936312;6476.676166191672;6495.8700825983215;6502.317256688074;3861.416819104154;3874.9418758718643;3875.5349358076646;3879.689624830007;3896.2597106549665;6110.541709371815;7571;7575.356094731899;7578.924210757822;7600.50596711212;6074.54440916933;7039.768040592876;7306.342429181293;7497.1003479581705;7508.849823003509;7675.194104619046;7698.34564062061;7709.691612335556;7711.03612048494;7735.265149810759;7378.889316660147;7386.482946193715;7393.297636724503;7398.630068496661;7417.072865891763;6163.599366041193;6261.810256051335;7219.891701624375;7258.891116633149;7260.2739726026975;6084.847878803065;7641.159472457914;7653.464257501922;7653.57905315213;7653.846923061619;4068.247374235776;4410.7208909417195;4592.448906131285;4628.490866004669;4635.096156249634;7127.39286185544;7193.208747037717;7288.599127047851;7294.635268236673;7302.6713797878165;7060.223375428802;7070.646467676698;7078.256783037707;7084.22073571917;7091.716331346688;7045.1898031727005;7048.788536343918;7050.0129981801565;7052.682629281797;7061.1173603299585;6698.162729658793;6915.654217289216;6954.235034146341;6988.720451181895;6995.335443132894;7146.7141314346845;7149.9285007149265;7153.892691609734;7161.892571611325;7161.928380716126;5632.5212356950115;6747.325267473213;6986.930130698628;6992.475564332797;7000.369966703021 16:56:40 INFO - PROCESS | 1692 | |5;yui.html;668.8695704337655;686.1526015371016;706.2302090721113;730.3244498838579;786.7718361675114;14910.329035193416;14967.101973881561;15172.468963586276;15173.620659483518;15190.392384304641;13909.304534773271;13980.790288145661;14006.439742410292;14009.509667161627;14014.859851401483;578.8523926398783;685.674304705266;839.3159574946399;849.9660013599464;872.7469033980138;861.28513333933;868.2619773192798;872.733816186063;873.2620935309653;876.6055275126187;816.4692949582759;911.3256190419108;913.6117150211134;915.6886658536097;916.564631799893;734.6547122852251;741.4735537768191;892.2683399612321;909.3361845852498;911.1344222988122;669.6718607882151;671.2549070531705;672.2873753820966;673.2257903411067;674.0092064664934;14761.33573989173;14812;14819.555413337617;14821.851781482155;14823.332950017168;12791.360431978457;12908.741825163444;13007.414666340037;13310.073528309074;13519.053666243366;10256.33333833306;10417.947910260476;10440.530176142092;10545.209109316833;10610;3520.4719292106133;3579.6062433132333;3630.473581330719;3646.4165733482782;3660.560732712065;83611;84323.57838210832;84563.99999999939;84649;84754.77673702931;9231.907680923105;9356.4386136832;9423.528823558794;9517.381370210915;9527.761805954906;16371.672566548841;20045.79954200439;20212.78723276608;20410.795892041187;20432.182712691327;7447.776566703008;7590.7722768317035;7602.087749470099;7661.080670319598;7667.846643067219;4014.638682518529;4069.308217603015;4071.5114186297833;4094.9795251023556;4110.34234522475;3597.6222496638;3636.4181730922924;3642.417213245868;3643.763155394891;3645.3802853514967;637.6206157336377;650.6909218121355;652.1456891472187;672.5023482622823;677.2448719677623;530.2761730238198;568.5451638689033;568.7412227436589;598.1147901106386;635.5424094651843;9127.908720912706;9235.676751313671;9261.30540209487;9375.296852736072;9423.057694230522;613.6747523812387;618.2735286038976;627.1314229791681;636.3795299582962;636.920384951881;3835.137094153793;4270.42349282849;4298.20483210607;4363.432753741993;4382.298832186835;82423;84383.73424398639;86010.56994714987;86121;86122;69649.65175174092;69763;69830.65084674544;73835;77059.61470192613;64423.67788161123;65247;66004.67990640161;66489.33510664832;67417.66291168513;8900.599473023858;8902.554872256233;8937.865932010895;9020.097990200928;9187.632494700138;49831.501684984134;50417.495825042744;50785;51689.48310516847;51777.446676599764;66294.67410651856;67683.32316676967;68657.65671171612;69833.30166698471;69996;11085.22403431752;11128.610498632508;11310.547578096784;11391.373474458984;11532.308061516336;11953.641390757943;12108.455119519467;12354.745561184016;12571.245725256147;12749;11348.943255284;11379.374134422686;11491.425428728697;11734.94132529332;11995.220310679779;11568.595099171489;11569.595064172714;11852.585159519376;11935.52257909674;12088.516459341528;10350.327228730108;10392.116670083127;11272.9436352821;11411.429428528707;12282.201656892274;9336.673216437392;9375.484348360633;9556.23550116003;9673;9901;8200.83598328042;8991.910080899108;9117;9335.906640933505;9751.073648003428 16:56:40 INFO - PROCESS | 1692 | __end_tp_report 16:56:40 INFO - PROCESS | 1692 | __start_cc_report 16:56:40 INFO - PROCESS | 1692 | _x_x_mozilla_cycle_collect,1409 16:56:40 INFO - PROCESS | 1692 | __end_cc_report 16:56:40 INFO - PROCESS | 1692 | __startTimestamp1455584200183__endTimestamp 16:56:40 INFO - PROCESS | 1692 | 16:56:40 INFO - PROCESS | 1692 | ------- Summary: start ------- 16:56:40 INFO - PROCESS | 1692 | Number of tests: 6 16:56:40 INFO - PROCESS | 1692 | 16:56:40 INFO - PROCESS | 1692 | [#0] dojo.html Cycles:165 Average:5757.28 Median:5973.10 stddev:637.67 (10.7%) stddev-sans-first:612.76 16:56:40 INFO - PROCESS | 1692 | Values: 3422.7 3480.2 3499.9 3514.6 3550.4 5637.2 5701.3 5705.6 5715.0 5724.4 4380.5 5618.8 5757.8 5881.2 5891.7 5125.0 5169.1 5181.5 5197.6 5269.6 5265.4 5274.8 5291.7 5296.9 5334.1 5148.6 5153.0 5250.8 5255.1 5275.3 5230.4 5247.5 5261.0 5285.2 5296.4 5083.2 5182.0 5205.0 5206.0 5242.4 5556.9 5685.5 5707.9 5723.3 5775.2 6201.2 6207.3 6217.7 6221.2 6231.9 6085.1 6263.0 6273.7 6277.8 6278.6 5828.1 5859.3 5876.1 5940.7 5941.4 6279.1 6287.5 6291.3 6291.4 6310.6 6059.8 6061.4 6116.2 6201.3 6213.7 6250.4 6304.0 6305.2 6317.5 6329.8 6216.7 6263.1 6271.6 6274.8 6287.7 5971.3 6001.5 6072.9 6089.4 6275.0 4880.0 4899.3 4912.8 4914.7 4921.0 4379.5 4405.1 4477.2 4481.9 4481.9 5570.9 5614.8 5624.1 5646.0 5734.8 6183.4 6310.7 6320.5 6332.0 6334.7 5648.4 5650.6 5663.6 5666.2 5686.4 5300.8 5382.4 5388.7 5390.1 5396.1 6268.8 6283.4 6326.9 6346.4 6352.9 6292.8 6297.6 6306.6 6321.9 6339.5 6176.7 6264.3 6294.3 6323.6 6325.5 6119.0 6247.2 6264.1 6269.7 6272.1 6255.9 6289.1 6302.5 6309.7 6312.9 5990.5 6124.5 6126.5 6132.5 6171.4 6120.7 6123.3 6131.5 6133.7 6137.0 5973.1 5975.2 5993.3 5994.0 6271.2 5941.6 6085.3 6088.5 6102.4 6122.9 5920.8 5953.7 5955.0 5957.2 5959.8 16:56:40 INFO - PROCESS | 1692 | 16:56:40 INFO - PROCESS | 1692 | [#1] ext.html Cycles:180 Average:58641.56 Median:36103.82 stddev:120115.28 (332.7%) stddev-sans-first:120372.80 16:56:40 INFO - PROCESS | 1692 | Values: 460.6 467.9 517.0 527.0 565.7 29496.3 29951.9 37483.0 37849.9 37959.0 38709.2 38974.6 38988.4 39015.4 39038.0 9444.6 9679.9 9683.3 9691.8 9697.2 9547.9 9702.0 9713.0 9715.1 9718.9 9085.3 9342.0 9800.2 9900.9 9908.5 9741.5 9752.7 9774.9 9809.4 9830.7 9454.7 9601.0 9604.9 9605.2 9629.8 38384.0 39066.0 39099.2 39111.2 39263.0 3299.7 3448.3 3672.5 3686.7 3695.3 27680.7 28367.4 28483.7 28525.3 28573.7 2788.7 2823.8 2856.2 2892.7 2971.2 458976.7 460567.0 460989.0 461326.0 461566.7 53108.7 54202.0 60672.4 61134.0 61495.4 49404.0 59594.5 59984.0 60364.1 60515.0 15770.7 15978.0 16003.1 16029.0 16041.4 10164.8 11429.0 11585.7 12355.3 12550.6 14327.7 18657.0 18735.7 18766.5 18804.0 7783.8 7801.2 8061.6 8065.2 8106.5 855.8 939.8 992.9 1019.4 1035.0 29432.4 29490.4 29741.0 30194.5 30238.0 1032.7 1037.4 1048.2 1050.4 1143.5 12764.1 12817.0 12830.6 12848.6 13355.5 509312.0 526578.4 526902.0 527006.0 529444.0 53912.0 54241.9 54252.5 54285.5 54413.7 1415.1 1431.1 1445.0 1447.5 1458.6 23579.2 27260.5 27914.0 27962.6 29455.0 35165.3 43461.6 50454.7 50503.0 50570.7 352002.0 354933.0 355131.0 355245.0 355285.0 27631.9 28069.4 28314.0 29037.4 29913.6 39314.8 41803.0 42400.8 42569.4 42640.6 34386.3 35509.8 35688.8 36101.0 36106.6 35599.9 35852.0 35991.6 36034.5 36068.0 34280.0 35221.3 35395.9 35480.0 35491.8 29306.0 31686.7 31689.0 31726.5 31727.4 24529.4 24546.9 24552.3 24658.0 24775.9 16:56:40 INFO - PROCESS | 1692 | 16:56:40 INFO - PROCESS | 1692 | [#2] jquery.html Cycles:180 Average:33436.25 Median:22454.78 stddev:107023.82 (476.6%) stddev-sans-first:107295.17 16:56:40 INFO - PROCESS | 1692 | Values: 324.3 360.4 364.3 366.7 369.6 15001.5 15472.6 19115.5 20058.3 20589.2 18791.9 18820.8 19387.3 19394.9 19735.3 4888.6 5565.4 5615.1 5616.9 5621.0 4047.4 4273.8 5597.1 5642.5 5963.2 6094.0 6129.7 6164.6 6168.0 6176.8 5998.9 6171.8 6172.9 6176.2 6183.9 5146.3 5257.1 5305.8 5307.0 5312.7 23860.9 23971.6 24116.8 24514.8 24680.3 2040.7 2181.7 2542.7 2593.8 2891.9 6509.5 12134.8 13935.7 14229.6 14333.1 1685.0 1751.6 1768.4 1783.4 1791.7 90074.0 92518.5 92615.1 93088.1 94179.5 8216.8 10404.5 10573.4 10606.2 10688.4 12542.4 12700.6 12702.7 12713.2 12713.6 8476.0 8492.6 8538.5 8604.3 8635.1 8834.6 8839.0 8856.0 8932.3 8934.4 6078.6 6162.9 6166.6 6175.9 6181.4 1644.6 1707.6 1734.6 1741.7 1802.1 891.1 892.5 935.7 957.1 1022.9 14977.2 19157.5 19436.6 19768.2 19962.0 855.9 981.8 1005.5 1038.1 1054.9 10836.6 11119.7 11154.9 11191.9 11231.1 514686.0 659226.0 660616.0 695040.0 710366.4 59592.4 62074.8 92408.1 94782.0 96184.0 1001.4 1042.6 1141.6 1143.0 1169.3 17553.2 17821.7 17896.2 17998.9 18302.3 32525.5 40635.8 44975.8 45092.5 47397.3 68622.0 68834.0 69831.7 71220.6 71396.6 6982.2 7366.1 7463.7 7529.9 7567.9 10487.5 11667.8 11811.6 11880.4 12015.9 6831.6 9335.5 9438.9 10565.3 10691.4 8526.0 8749.3 10046.6 10050.9 10362.2 9485.0 9821.8 10269.3 10736.6 10794.7 7295.3 7468.9 7507.0 7543.4 7619.3 6737.4 8670.5 10295.8 10448.2 10469.5 16:56:40 INFO - PROCESS | 1692 | 16:56:40 INFO - PROCESS | 1692 | [#3] mootools.html Cycles:180 Average:6149.73 Median:5102.99 stddev:3260.17 (63.9%) stddev-sans-first:3248.83 16:56:40 INFO - PROCESS | 1692 | Values: 1288.6 1484.8 1515.8 1745.9 1857.7 8041.3 8646.2 8824.9 8828.2 8849.2 8559.5 8835.8 8838.4 8841.9 8868.6 2180.5 2242.8 2426.5 2496.3 2523.5 2482.5 2502.6 2514.9 2517.8 2518.1 2447.3 2486.1 2491.9 2497.9 2503.0 2414.6 2495.3 2495.5 2496.1 2499.8 2457.3 2488.6 2508.4 2508.6 2513.8 8921.8 8976.2 9002.4 9005.6 9013.4 5398.3 5539.4 5576.7 5577.9 5600.2 3148.2 3200.8 3525.1 3850.0 3861.7 1047.4 1053.5 1065.0 1100.8 1101.7 12286.0 12302.3 12333.2 12338.3 12356.8 4929.3 4959.9 4977.8 5022.7 5050.5 10412.9 10426.7 10438.0 10452.7 10470.6 5604.7 5608.5 5612.9 5613.5 5615.5 4962.4 5102.6 5103.4 5107.5 5112.2 3682.6 3787.7 3919.2 3959.5 4011.5 1142.3 1274.5 1311.9 1326.0 1328.4 1305.8 1322.9 1328.3 1349.7 1353.4 8127.6 8164.8 8186.9 8188.3 8198.4 1172.4 1192.5 1192.9 1199.1 1216.4 6255.3 6263.9 6343.0 6345.7 6353.9 10640.4 11086.8 11098.9 11099.0 11116.6 10482.6 10787.7 10896.8 10904.3 10929.7 8409.7 8421.4 8503.6 8515.0 8515.7 7747.3 7905.2 7972.8 7986.2 8005.8 9452.8 9824.6 9886.3 9915.4 9939.2 9854.3 10133.4 10243.0 10313.5 10336.2 6779.8 7506.2 7554.1 7555.0 7645.1 6236.3 7707.9 8255.6 8257.7 8269.6 7563.4 7765.0 7781.2 7797.3 7892.9 7530.5 7559.4 7581.4 7658.1 7699.2 6335.6 7786.8 7796.9 7805.9 7904.9 7021.0 7050.5 7086.9 7094.0 7106.1 6062.2 7256.9 7270.7 7271.1 7273.9 16:56:40 INFO - PROCESS | 1692 | 16:56:40 INFO - PROCESS | 1692 | [#4] prototype.html Cycles:180 Average:5720.76 Median:6440.60 stddev:1819.86 (28.3%) stddev-sans-first:1779.16 16:56:40 INFO - PROCESS | 1692 | Values: 314.9 322.1 323.6 328.9 330.0 6146.5 6574.6 6592.7 6596.1 6610.8 6418.6 6548.4 6549.6 6549.9 6565.1 4053.3 4901.1 4913.9 4920.8 4922.5 4760.0 4884.3 4892.7 4914.5 4927.5 4825.1 4831.1 4837.2 4851.2 4878.6 4622.6 4748.5 4863.9 4872.5 4892.5 3683.8 4111.8 4123.2 4125.7 4133.5 6236.6 6270.1 6313.3 6316.9 6327.0 5389.4 5494.3 5584.1 5666.0 5682.5 5836.2 6811.3 6882.8 6908.7 6914.2 4652.7 4655.0 4658.2 4660.7 4667.8 5966.8 7073.6 7402.9 7416.5 7419.0 4768.3 4769.8 4773.0 4774.4 4778.6 3993.3 4048.5 4839.0 4853.4 4855.2 5699.8 5704.4 5711.6 5715.1 5718.9 6757.3 7025.4 7059.7 7060.3 7074.6 1662.8 1681.3 1683.3 1685.0 1685.6 1071.0 1086.5 1096.2 1103.3 1104.4 6462.5 6480.3 6492.7 6508.1 6509.1 7237.6 7245.7 7257.4 7266.9 7269.8 6273.7 6471.1 6476.7 6495.9 6502.3 3861.4 3874.9 3875.5 3879.7 3896.3 6110.5 7571.0 7575.4 7578.9 7600.5 6074.5 7039.8 7306.3 7497.1 7508.8 7675.2 7698.3 7709.7 7711.0 7735.3 7378.9 7386.5 7393.3 7398.6 7417.1 6163.6 6261.8 7219.9 7258.9 7260.3 6084.8 7641.2 7653.5 7653.6 7653.8 4068.2 4410.7 4592.4 4628.5 4635.1 7127.4 7193.2 7288.6 7294.6 7302.7 7060.2 7070.6 7078.3 7084.2 7091.7 7045.2 7048.8 7050.0 7052.7 7061.1 6698.2 6915.7 6954.2 6988.7 6995.3 7146.7 7149.9 7153.9 7161.9 7161.9 5632.5 6747.3 6986.9 6992.5 7000.4 16:56:40 INFO - PROCESS | 1692 | 16:56:40 INFO - PROCESS | 1692 | [#5] yui.html Cycles:180 Average:17997.86 Median:637.27 stddev:24819.66 (3894.7%) stddev-sans-first:24855.17 16:56:40 INFO - PROCESS | 1692 | Values: 668.9 686.2 706.2 730.3 786.8 14910.3 14967.1 15172.5 15173.6 15190.4 13909.3 13980.8 14006.4 14009.5 14014.9 578.9 685.7 839.3 850.0 872.7 861.3 868.3 872.7 873.3 876.6 816.5 911.3 913.6 915.7 916.6 734.7 741.5 892.3 909.3 911.1 669.7 671.3 672.3 673.2 674.0 14761.3 14812.0 14819.6 14821.9 14823.3 12791.4 12908.7 13007.4 13310.1 13519.1 10256.3 10417.9 10440.5 10545.2 10610.0 3520.5 3579.6 3630.5 3646.4 3660.6 83611.0 84323.6 84564.0 84649.0 84754.8 9231.9 9356.4 9423.5 9517.4 9527.8 16371.7 20045.8 20212.8 20410.8 20432.2 7447.8 7590.8 7602.1 7661.1 7667.8 4014.6 4069.3 4071.5 4095.0 4110.3 3597.6 3636.4 3642.4 3643.8 3645.4 637.6 650.7 652.1 672.5 677.2 530.3 568.5 568.7 598.1 635.5 9127.9 9235.7 9261.3 9375.3 9423.1 613.7 618.3 627.1 636.4 636.9 3835.1 4270.4 4298.2 4363.4 4382.3 82423.0 84383.7 86010.6 86121.0 86122.0 69649.7 69763.0 69830.7 73835.0 77059.6 64423.7 65247.0 66004.7 66489.3 67417.7 8900.6 8902.6 8937.9 9020.1 9187.6 49831.5 50417.5 50785.0 51689.5 51777.4 66294.7 67683.3 68657.7 69833.3 69996.0 11085.2 11128.6 11310.5 11391.4 11532.3 11953.6 12108.5 12354.7 12571.2 12749.0 11348.9 11379.4 11491.4 11734.9 11995.2 11568.6 11569.6 11852.6 11935.5 12088.5 10350.3 10392.1 11272.9 11411.4 12282.2 9336.7 9375.5 9556.2 9673.0 9901.0 8200.8 8991.9 9117.0 9335.9 9751.1 16:56:40 INFO - PROCESS | 1692 | -------- Summary: end -------- 16:56:40 INFO - PROCESS | 1692 | 16:56:40 INFO - TEST-INFO | 1692: exit 0 16:56:40 INFO - TEST-OK | dromaeo_css | took 1114695ms 16:56:40 INFO - TEST-START | kraken 16:56:40 INFO - operating with platform_type : mac_ 16:56:40 INFO - Initialising browser for kraken test... 16:56:40 INFO - TEST-INFO | started process 1698 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/tmpV05TdB/profile http://localhost:49274/getInfo.html) 16:56:42 INFO - PROCESS | 1698 | __metrics Screen width/height:1600/1200 16:56:42 INFO - PROCESS | 1698 | colorDepth:24 16:56:42 INFO - PROCESS | 1698 | Browser inner width/height: 1024/689 16:56:42 INFO - PROCESS | 1698 | __metrics 16:56:43 INFO - PROCESS | 1698 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:56:43 INFO - PROCESS | 1698 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:56:43 INFO - TEST-INFO | 1698: exit 0 16:56:43 INFO - Browser initialized. 16:56:43 INFO - Running cycle 1/1 for kraken test... 16:56:43 INFO - TEST-INFO | started process 1700 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/tmpV05TdB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:56:55 INFO - PROCESS | 1700 | RSS: Main: 245866496 16:56:55 INFO - PROCESS | 1700 | 16:56:58 INFO - PROCESS | 1700 | 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:56:58 INFO - PROCESS | 1700 | RSS: Main: 292319232 16:56:58 INFO - PROCESS | 1700 | 16:57:01 INFO - PROCESS | 1700 | 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:57:02 INFO - PROCESS | 1700 | RSS: Main: 302469120 16:57:02 INFO - PROCESS | 1700 | 16:57:05 INFO - PROCESS | 1700 | 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:57:05 INFO - PROCESS | 1700 | RSS: Main: 284577792 16:57:05 INFO - PROCESS | 1700 | 16:57:07 INFO - PROCESS | 1700 | 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:57:08 INFO - PROCESS | 1700 | RSS: Main: 288866304 16:57:08 INFO - PROCESS | 1700 | 16:57:10 INFO - PROCESS | 1700 | 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:57:11 INFO - PROCESS | 1700 | RSS: Main: 289492992 16:57:11 INFO - PROCESS | 1700 | 16:57:13 INFO - PROCESS | 1700 | 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:57:14 INFO - PROCESS | 1700 | RSS: Main: 290410496 16:57:14 INFO - PROCESS | 1700 | 16:57:17 INFO - PROCESS | 1700 | 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:57:17 INFO - PROCESS | 1700 | RSS: Main: 289890304 16:57:17 INFO - PROCESS | 1700 | 16:57:20 INFO - PROCESS | 1700 | 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:57:21 INFO - PROCESS | 1700 | RSS: Main: 289439744 16:57:21 INFO - PROCESS | 1700 | 16:57:22 INFO - PROCESS | 1700 | 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:57:23 INFO - PROCESS | 1700 | RSS: Main: 323874816 16:57:23 INFO - PROCESS | 1700 | 16:57:25 INFO - PROCESS | 1700 | 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:57:25 INFO - PROCESS | 1700 | RSS: Main: 322756608 16:57:25 INFO - PROCESS | 1700 | 16:57:27 INFO - PROCESS | 1700 | 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) 16:57:28 INFO - PROCESS | 1700 | RSS: Main: 332058624 16:57:28 INFO - PROCESS | 1700 | 16:57:31 INFO - PROCESS | 1700 | 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) 16:57:31 INFO - PROCESS | 1700 | RSS: Main: 334155776 16:57:31 INFO - PROCESS | 1700 | 16:57:34 INFO - PROCESS | 1700 | 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) 16:57:34 INFO - PROCESS | 1700 | RSS: Main: 334544896 16:57:34 INFO - PROCESS | 1700 | 16:57:36 INFO - PROCESS | 1700 | 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) 16:57:36 INFO - PROCESS | 1700 | RSS: Main: 395444224 16:57:36 INFO - PROCESS | 1700 | 16:57:36 INFO - PROCESS | 1700 | __start_tp_report 16:57:36 INFO - PROCESS | 1700 | _x_x_mozilla_page_load 16:57:36 INFO - PROCESS | 1700 | _x_x_mozilla_page_load_details 16:57:36 INFO - PROCESS | 1700 | |i|pagename|runs| 16:57:36 INFO - PROCESS | 1700 | |0;ai-astar;154;155;158;109;112;113;117;111;109;109 16:57:36 INFO - PROCESS | 1700 | |1;audio-beat-detection;166;123;141;155;123;141;137;121;144;149 16:57:36 INFO - PROCESS | 1700 | |2;audio-dft;185;187;186;183;185;186;183;179;163;249 16:57:36 INFO - PROCESS | 1700 | |3;audio-fft;76;74;83;77;60;57;58;75;77;57 16:57:36 INFO - PROCESS | 1700 | |4;audio-oscillator;91;96;125;84;116;127;110;76;78;105 16:57:36 INFO - PROCESS | 1700 | |5;imaging-gaussian-blur;86;91;85;92;85;91;85;92;85;92 16:57:36 INFO - PROCESS | 1700 | |6;imaging-darkroom;94;94;95;94;95;94;94;93;94;94 16:57:36 INFO - PROCESS | 1700 | |7;imaging-desaturate;86;85;85;87;86;87;84;86;82;85 16:57:36 INFO - PROCESS | 1700 | |8;json-parse-financial;53;54;56;55;54;52;54;63;51;52 16:57:36 INFO - PROCESS | 1700 | |9;json-stringify-tinderbox;63;70;61;77;74;71;69;66;65;66 16:57:36 INFO - PROCESS | 1700 | |10;stanford-crypto-aes;83;85;81;82;84;95;107;109;105;84 16:57:36 INFO - PROCESS | 1700 | |11;stanford-crypto-ccm;123;125;125;127;111;126;118;123;124;152 16:57:36 INFO - PROCESS | 1700 | |12;stanford-crypto-pbkdf2;128;125;140;139;137;126;136;138;138;137 16:57:36 INFO - PROCESS | 1700 | |13;stanford-crypto-sha256-iterative;67;67;66;66;66;67;66;67;66;66 16:57:36 INFO - PROCESS | 1700 | __end_tp_report 16:57:36 INFO - PROCESS | 1700 | __start_cc_report 16:57:36 INFO - PROCESS | 1700 | _x_x_mozilla_cycle_collect,1209 16:57:36 INFO - PROCESS | 1700 | __end_cc_report 16:57:36 INFO - PROCESS | 1700 | __startTimestamp1455584256651__endTimestamp 16:57:36 INFO - PROCESS | 1700 | 16:57:36 INFO - PROCESS | 1700 | ------- Summary: start ------- 16:57:36 INFO - PROCESS | 1700 | Number of tests: 14 16:57:36 INFO - PROCESS | 1700 | 16:57:36 INFO - PROCESS | 1700 | [#0] ai-astar Cycles:10 Average:124.70 Median:115.00 stddev:21.53 (18.7%) stddev-sans-first:20.05 16:57:36 INFO - PROCESS | 1700 | Values: 154.0 155.0 158.0 109.0 112.0 113.0 117.0 111.0 109.0 109.0 16:57:36 INFO - PROCESS | 1700 | 16:57:36 INFO - PROCESS | 1700 | [#1] audio-beat-detection Cycles:10 Average:140.00 Median:142.50 stddev:14.71 (10.3%) stddev-sans-first:12.23 16:57:36 INFO - PROCESS | 1700 | Values: 166.0 123.0 141.0 155.0 123.0 141.0 137.0 121.0 144.0 149.0 16:57:36 INFO - PROCESS | 1700 | 16:57:36 INFO - PROCESS | 1700 | [#2] audio-dft Cycles:10 Average:188.60 Median:185.50 stddev:22.36 (12.1%) stddev-sans-first:23.68 16:57:36 INFO - PROCESS | 1700 | Values: 185.0 187.0 186.0 183.0 185.0 186.0 183.0 179.0 163.0 249.0 16:57:36 INFO - PROCESS | 1700 | 16:57:36 INFO - PROCESS | 1700 | [#3] audio-fft Cycles:10 Average:69.40 Median:75.50 stddev:10.12 (13.4%) stddev-sans-first:10.45 16:57:36 INFO - PROCESS | 1700 | Values: 76.0 74.0 83.0 77.0 60.0 57.0 58.0 75.0 77.0 57.0 16:57:36 INFO - PROCESS | 1700 | 16:57:36 INFO - PROCESS | 1700 | [#4] audio-oscillator Cycles:10 Average:100.80 Median:77.00 stddev:18.68 (24.3%) stddev-sans-first:19.48 16:57:36 INFO - PROCESS | 1700 | Values: 91.0 96.0 125.0 84.0 116.0 127.0 110.0 76.0 78.0 105.0 16:57:36 INFO - PROCESS | 1700 | 16:57:36 INFO - PROCESS | 1700 | [#5] imaging-gaussian-blur Cycles:10 Average:88.40 Median:91.00 stddev:3.41 (3.7%) stddev-sans-first:3.50 16:57:36 INFO - PROCESS | 1700 | Values: 86.0 91.0 85.0 92.0 85.0 91.0 85.0 92.0 85.0 92.0 16:57:36 INFO - PROCESS | 1700 | 16:57:36 INFO - PROCESS | 1700 | [#6] imaging-darkroom Cycles:10 Average:94.10 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 16:57:36 INFO - PROCESS | 1700 | Values: 94.0 94.0 95.0 94.0 95.0 94.0 94.0 93.0 94.0 94.0 16:57:36 INFO - PROCESS | 1700 | 16:57:36 INFO - PROCESS | 1700 | [#7] imaging-desaturate Cycles:10 Average:85.30 Median:86.00 stddev:1.49 (1.7%) stddev-sans-first:1.56 16:57:36 INFO - PROCESS | 1700 | Values: 86.0 85.0 85.0 87.0 86.0 87.0 84.0 86.0 82.0 85.0 16:57:36 INFO - PROCESS | 1700 | 16:57:36 INFO - PROCESS | 1700 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:54.00 stddev:3.37 (6.2%) stddev-sans-first:3.54 16:57:36 INFO - PROCESS | 1700 | Values: 53.0 54.0 56.0 55.0 54.0 52.0 54.0 63.0 51.0 52.0 16:57:36 INFO - PROCESS | 1700 | 16:57:36 INFO - PROCESS | 1700 | [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:69.50 stddev:4.96 (7.1%) stddev-sans-first:4.89 16:57:36 INFO - PROCESS | 1700 | Values: 63.0 70.0 61.0 77.0 74.0 71.0 69.0 66.0 65.0 66.0 16:57:36 INFO - PROCESS | 1700 | 16:57:36 INFO - PROCESS | 1700 | [#10] stanford-crypto-aes Cycles:10 Average:91.50 Median:83.50 stddev:11.39 (13.6%) stddev-sans-first:11.66 16:57:36 INFO - PROCESS | 1700 | Values: 83.0 85.0 81.0 82.0 84.0 95.0 107.0 109.0 105.0 84.0 16:57:36 INFO - PROCESS | 1700 | 16:57:36 INFO - PROCESS | 1700 | [#11] stanford-crypto-ccm Cycles:10 Average:125.40 Median:125.00 stddev:10.47 (8.4%) stddev-sans-first:11.07 16:57:36 INFO - PROCESS | 1700 | Values: 123.0 125.0 125.0 127.0 111.0 126.0 118.0 123.0 124.0 152.0 16:57:36 INFO - PROCESS | 1700 | 16:57:36 INFO - PROCESS | 1700 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:134.40 Median:137.50 stddev:5.72 (4.2%) stddev-sans-first:5.58 16:57:36 INFO - PROCESS | 1700 | Values: 128.0 125.0 140.0 139.0 137.0 126.0 136.0 138.0 138.0 137.0 16:57:36 INFO - PROCESS | 1700 | 16:57:36 INFO - PROCESS | 1700 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:66.50 stddev:0.52 (0.8%) stddev-sans-first:0.50 16:57:36 INFO - PROCESS | 1700 | Values: 67.0 67.0 66.0 66.0 66.0 67.0 66.0 67.0 66.0 66.0 16:57:36 INFO - PROCESS | 1700 | -------- Summary: end -------- 16:57:36 INFO - PROCESS | 1700 | 16:57:37 INFO - TEST-INFO | 1700: exit 0 16:57:37 INFO - TEST-OK | kraken | took 56670ms 16:57:37 INFO - SUITE-END | took 1171s 16:57:37 INFO - Completed test suite (00:19:31) 16:57:37 INFO - Working with test: dromaeo_css 16:57:37 INFO - Generating results file: dromaeo_css 16:57:37 INFO - Working with test: kraken 16:57:37 INFO - Generating results file: kraken 16:57:37 INFO - javascript benchmark 16:57:37 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:57:37 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 16:57:37 INFO - process_Request line: dromaeo_css 7455.69 graph.html#tests=[[72,64,59]] 16:57:37 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:57:37 INFO - process_Request line: kraken 1431.60 graph.html#tests=[[232,64,59]] 16:57:37 INFO - RETURN: dromaeo_css: 7455.69 16:57:37 INFO - RETURN: kraken: 1431.60 16:57:37 INFO - javascript benchmark 16:57:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3422.726181905447, 3480.164760457491, 3499.897532277334, 3514.648535146485, 3550.4141816600263, 5637.182608521772, 5701.344345400275, 5705.572082093844, 5714.971425142874, 5724.427557244274, 4380.496242932056, 5618.775248990036, 5757.827265182052, 5881.235439392884, 5891.705414729267, 5125.0, 5169.121249387613, 5181.481851814826, 5197.558207552363, 5269.604779641523, 5265.420803711589, 5274.789008439677, 5291.708956007418, 5296.867578310554, 5334.093204155283, 5148.639595228336, 5153.0, 5250.816221432251, 5255.106631872591, 5275.340582427197, 5230.372355317386, 5247.501487358695, 5261.026710058613, 5285.207218917155, 5296.390915044781, 5083.212102124176, 5182.041322355376, 5205.0, 5206.0368831766245, 5242.370915490127, 5556.91664625031, 5685.459881311269, 5707.857303567403, 5723.255976723041, 5775.16260142277, 6201.224846894138, 6207.255129384503, 6217.658028808413, 6221.160143380631, 6231.875362492725, 6085.117657939618, 6262.968685156545, 6273.717682704244, 6277.811665650038, 6278.560500764948, 5828.0966450200285, 5859.267591551056, 5876.118582212703, 5940.673262970535, 5941.405859414067, 6279.0895320178315, 6287.49700023997, 6291.307956124822, 6291.370862913672, 6310.558260921692, 6059.757609695563, 6061.418801126416, 6116.244470650255, 6201.317855035943, 6213.65824879636, 6250.3749625037135, 6304.0, 6305.211848518935, 6317.4946004319545, 6329.778457753957, 6216.658083805343, 6263.091851681572, 6271.62370257786, 6274.843128921813, 6287.717052732638, 5971.313298970587, 6001.459868611846, 6072.878542429126, 6089.421504957022, 6274.968625156845, 4879.975600122048, 4899.265110233494, 4912.828051018198, 4914.680545764514, 4920.975395123001, 4379.540148284448, 4405.074934263776, 4477.194105061055, 4481.910361792746, 4481.910361792811, 5570.888582228333, 5614.775408983676, 5624.100143976944, 5646.0, 5734.77060917567, 6183.350748171467, 6310.7475700971445, 6320.494360451153, 6331.96834015827, 6334.651594162366, 5648.435156484401, 5650.63270887391, 5663.631863928831, 5666.15007748841, 5686.3744988051285, 5300.787968481295, 5382.381026182039, 5388.703621300866, 5390.110631745796, 5396.1366181410785, 6268.843278918063, 6283.403076707706, 6326.936730632727, 6346.365363463617, 6352.872942541216, 6292.842678933063, 6297.559170857996, 6306.558540902093, 6321.936780632319, 6339.492840572835, 6176.66028368444, 6264.310925798068, 6294.339094395023, 6323.588966717149, 6325.525585581192, 6118.9846826261555, 6247.187865577446, 6264.060390941395, 6269.655168965751, 6272.121902933502, 6255.906161407674, 6289.056641503811, 6302.495800335871, 6309.684515774101, 6312.873742525032, 5990.520758339235, 6124.479419249414, 6126.540509461897, 6132.540059495466, 6171.382861713792, 6120.660465672032, 6123.313124872426, 6131.4990048534, 6133.73253493014, 6136.978641397139, 5973.104034394875, 5975.193348898017, 5993.280806303272, 5994.0409534474275, 6271.184745983175, 5941.643501389931, 6085.300190478151, 6088.452039316483, 6102.420270074336, 6122.908156377569, 5920.763169473345, 5953.6725480097275, 5955.0, 5957.225560677084, 5959.821205363846], "unit": "score", "name": "dojo.html", "value": 5717.530791229843}, {"lowerIsBetter": false, "replicates": [460.5923757474634, 467.9298105284207, 517.0279873837187, 526.9671443969819, 565.6634302589957, 29496.26259343515, 29951.850240748794, 37483.0, 37849.86450406492, 37959.0, 38709.225815483675, 38974.61025389745, 38988.41517377242, 39015.41476877849, 39038.0, 9444.622215111387, 9679.854802177973, 9683.322167448281, 9691.806163876718, 9697.224222062217, 9547.904520954806, 9702.0, 9713.0, 9715.125638692516, 9718.902810971906, 9085.273178145733, 9341.95329023354, 9800.16698580618, 9900.90099099007, 9908.504574771268, 9741.512924353789, 9752.658656946973, 9774.853377199348, 9809.362391444605, 9830.655927042591, 9454.716358509255, 9600.95199524005, 9604.90395096047, 9605.231581473536, 9629.807403851953, 38384.0, 39066.0, 39099.218015639526, 39111.21777564433, 39263.01842453933, 3299.653536378694, 3448.258624395767, 3672.5042119313816, 3686.705063594906, 3695.2791412267297, 27680.723192768015, 28367.43265134686, 28483.715162848315, 28525.28686782826, 28573.714262857313, 2788.7490125888567, 2823.816451930618, 2856.22881821909, 2892.681805001448, 2971.2126286534085, 458976.70511647564, 460567.0, 460989.0, 461326.0, 461566.69216654036, 53108.734456328246, 54202.0, 60672.39327606756, 61134.0, 61495.38504614986, 49404.0, 59594.51013724605, 59984.0, 60364.09453858196, 60515.0, 15770.684586308209, 15978.0, 16003.119828409317, 16028.95811772231, 16041.358345666276, 10164.796704065877, 11429.0, 11585.6524304271, 12355.32045737493, 12550.623481295575, 14327.713445731028, 18657.0, 18735.718964215546, 18766.53083672919, 18804.0, 7783.80540486481, 7801.219878012267, 8061.556614386265, 8065.153158918347, 8106.473079249948, 855.8074433252468, 939.8120375924842, 992.9106380425652, 1019.3883669798211, 1034.9793004139874, 29432.411351772844, 29490.410191796043, 29741.0, 30194.54708179379, 30238.0, 1032.7211652853687, 1037.3620223562605, 1048.156234231451, 1050.3540322701483, 1143.5311522275993, 12764.106512544218, 12816.974642028616, 12830.615081547568, 12848.550300739429, 13355.46578136883, 509312.0, 526578.3671081697, 526902.0, 527006.0, 529444.0, 53912.0, 54241.91516169733, 54252.45747542474, 54285.45714542804, 54413.72793136009, 1415.0872687116753, 1431.141315210886, 1444.978325325142, 1447.4789075932867, 1458.6134674311315, 23579.174728884405, 27260.454790903674, 27914.0, 27962.580561292005, 29455.0, 35165.296694066485, 43461.565384345755, 50454.747726261136, 50503.0, 50570.74714626551, 352002.0, 354933.0, 355131.0, 355245.0, 355285.0, 27631.894724210808, 28069.43861122807, 28314.009009684563, 29037.41925161443, 29913.551296730133, 39314.80342598383, 41803.0, 42400.78799605982, 42569.361459577514, 42640.57359426366, 34386.31227375389, 35509.82245088758, 35688.82155589206, 36101.0, 36106.63893361033, 35599.92615986361, 35852.0, 35991.64008359988, 36034.4594831083, 36068.0, 34280.0, 35221.29557408889, 35395.93812185639, 35480.0, 35491.82254088713, 29306.0, 31686.68313316837, 31689.0, 31726.524102138024, 31727.36545269128, 24529.386765331008, 24546.87726561356, 24552.33542475835, 24658.01367945334, 24775.876120619283], "unit": "score", "name": "ext.html", "value": 18833.4420733332}, {"lowerIsBetter": false, "replicates": [324.2606856367482, 360.41792505104246, 364.25146324303563, 366.67732395491964, 369.62483079674155, 15001.549953501413, 15472.613184670388, 19115.52211194719, 20058.297959571417, 20589.176432942702, 18791.932887382376, 18820.811791882075, 19387.32144374947, 19394.93327866967, 19735.309264175758, 4888.5600295973445, 5565.443455654443, 5615.129654903497, 5616.9157462638095, 5621.016322143629, 4047.433359329696, 4273.764942928137, 5597.104463285875, 5642.463965923252, 5963.194968679238, 6094.0, 6129.662868542228, 6164.568480206387, 6168.0439531872635, 6176.8455788605415, 5998.8800223995495, 6171.753129874822, 6172.938270617304, 6176.227971503562, 6183.9381606183815, 5146.330976973007, 5257.08001099806, 5305.814296499604, 5307.0, 5312.654677445954, 23860.89808324924, 23971.640425393634, 24116.758832411626, 24514.754852451602, 24680.25959221208, 2040.6938959156098, 2181.6727490876337, 2542.733013033623, 2593.832775251126, 2891.8698658560415, 6509.479241660656, 12134.757304853942, 13935.651608709763, 14229.644258893506, 14333.140011599233, 1684.983150168507, 1751.5971326594827, 1768.3810666266832, 1783.4382169616529, 1791.7401976713434, 90074.0, 92518.53740731321, 92615.07384926132, 93088.06911930862, 94179.52910235473, 8216.835663286702, 10404.479776011169, 10573.418461984511, 10606.204534659932, 10688.358698478116, 12542.435590398454, 12700.555480558136, 12702.682432939066, 12713.237205767684, 12713.618591442086, 8475.957620211859, 8492.575371231414, 8538.487690738575, 8604.268637165911, 8635.093315201939, 8834.64661413549, 8838.955805220932, 8856.025837157908, 8932.330075244383, 8934.374593778502, 6078.574499785061, 6162.938370616326, 6166.630002199882, 6175.876482470326, 6181.350958149419, 1644.629958259382, 1707.6413953069994, 1734.6357264974497, 1741.6777896089263, 1802.12596890508, 891.1177933845446, 892.5225004622625, 935.6912218967724, 957.1194501059042, 1022.9028242316969, 14977.176255305845, 19157.521061973563, 19436.61126777485, 19768.209271628974, 19962.0, 855.8972923249125, 981.8379967305315, 1005.4520286443906, 1038.065740833256, 1054.8681414823147, 10836.620718274822, 11119.666410007712, 11154.944225278983, 11191.888081119085, 11231.10151187903, 514686.0, 659226.0, 660616.0, 695040.0, 710366.4481677559, 59592.404075958686, 62074.75850482965, 92408.07591923994, 94782.0, 96184.0, 1001.4191768774239, 1042.551702767802, 1141.5559317463415, 1142.9771404572027, 1169.3393232823428, 17553.210105545535, 17821.73267401016, 17896.194671239566, 17998.91000544989, 18302.26790928401, 32525.512117317787, 40635.79682101689, 44975.775121124185, 45092.54907450883, 47397.34109306158, 68622.0, 68834.0, 69831.65084174546, 71220.64389678018, 71396.64301678458, 6982.231954485104, 7366.079240094989, 7463.701451941862, 7529.887051694339, 7567.9243207569425, 10487.52806123711, 11667.824982625438, 11811.586594469152, 11880.386315010684, 12015.939920300343, 6831.590104593542, 9335.533223338942, 9438.914524829457, 10565.313254638424, 10691.358518488916, 8526.019507756688, 8749.343799214957, 10046.598136074475, 10050.89949100529, 10362.171026317727, 9484.956654768108, 9821.803563928825, 10269.332493387907, 10736.570537178426, 10794.73013174677, 7295.270472952874, 7468.850622987401, 7507.0, 7543.43424243173, 7619.314261716472, 6737.393634572912, 8670.479771213748, 10295.845562316721, 10448.164146868081, 10469.476526173814], "unit": "score", "name": "jquery.html", "value": 9044.160036322432}, {"lowerIsBetter": false, "replicates": [1288.5812111063906, 1484.8366679665235, 1515.8105236845395, 1745.9039752813599, 1857.6656201883657, 8041.316488098511, 8646.17861303176, 8824.8676269856, 8828.205461508463, 8849.159329863669, 8559.486430814155, 8835.779105522364, 8838.381313308071, 8841.867371989425, 8868.645254189842, 2180.5093853882827, 2242.7981481666648, 2426.5389575980594, 2496.2885577610386, 2523.5457617628817, 2482.466269752012, 2502.637117617944, 2514.88683009265, 2517.773400393964, 2518.106072344319, 2447.339218411028, 2486.105002199216, 2491.862947537885, 2497.887595058227, 2502.9749702503013, 2414.553307638084, 2495.301315631626, 2495.4759500505006, 2496.113879572744, 2499.8375105618074, 2457.3242358351595, 2488.639147323646, 2508.4481414088873, 2508.5610018246734, 2513.7611926866916, 8921.821563568757, 8976.23701985332, 9002.369834111614, 9005.639774409081, 9013.36906416551, 5398.2982212312545, 5539.446055394468, 5576.7211639417865, 5577.8605534861545, 5600.187972743929, 3148.2286839724416, 3200.807951522893, 3525.1363415962996, 3849.9807500962315, 3861.6717579005817, 1047.3768107975743, 1053.5259133390005, 1064.978700425995, 1100.757833276678, 1101.6639924822925, 12286.0, 12302.323372214525, 12333.198342107824, 12338.321392323418, 12356.814647780291, 4929.285253638202, 4959.876003099879, 4977.776000080005, 5022.723750193702, 5050.4697006814495, 10412.947935260276, 10426.68719938403, 10438.008389203014, 10452.738681533023, 10470.581176752998, 5604.6917419541505, 5608.523275521545, 5612.887742245214, 5613.46672066153, 5615.466530679579, 4962.379702537183, 5102.591792656579, 5103.387593488805, 5107.514786095315, 5112.233165025202, 3682.5580930288, 3787.659110680052, 3919.2161567686576, 3959.4852669152824, 4011.4785077940264, 1142.2575326037975, 1274.5347947998914, 1311.9409626566828, 1326.0187461278776, 1328.4088580581742, 1305.7845455499926, 1322.8544860065385, 1328.3424704771007, 1349.6625843539116, 1353.3842101843638, 8127.59362031896, 8164.836703265902, 8186.918130818734, 8188.344932405513, 8198.38512111594, 1172.4313707851686, 1192.469351138735, 1192.8628207756046, 1199.1366216324232, 1216.4100411300512, 6255.280642726145, 6263.874722505524, 6342.968285158637, 6345.650989195638, 6353.936460635427, 10640.414777187329, 11086.778264434666, 11098.889011109946, 11099.001089901947, 11116.61091861781, 10482.63310784119, 10787.730306742395, 10896.782064358827, 10904.291221070605, 10929.672109836718, 8409.705660301861, 8421.410501264974, 8503.61733721984, 8514.957425212835, 8515.659373624985, 7747.30274275318, 7905.169957154646, 7972.800679983046, 7986.241307075818, 8005.799855003672, 9452.810943781224, 9824.557894894604, 9886.30795844284, 9915.355501892354, 9939.155171810187, 9854.260930430102, 10133.391996480235, 10243.026912443305, 10313.535890885078, 10336.17310615164, 6779.796606101825, 7506.211847755907, 7554.131274903457, 7555.017847679766, 7645.120811106572, 6236.282827474898, 7707.884381734167, 8255.587220639065, 8257.669693212205, 8269.586520673822, 7563.357114645317, 7764.961175194087, 7781.2218778124, 7797.337226335825, 7892.881606776018, 7530.510516816389, 7559.357454616199, 7581.355584775356, 7658.081030276402, 7699.191584883507, 6335.588186767845, 7786.805329866798, 7796.883046754417, 7805.946197263297, 7904.881426778718, 7020.964895175492, 7050.506464547432, 7086.893696594659, 7094.006839042435, 7106.111736032996, 6062.242219722535, 7256.9274307256255, 7270.745523906638, 7271.054762880792, 7273.927260727325], "unit": "score", "name": "mootools.html", "value": 5008.449876578543}, {"lowerIsBetter": false, "replicates": [314.8598873501292, 322.07885447619805, 323.61328212785725, 328.949012903, 330.0083249834251, 6146.539009574278, 6574.605523668577, 6592.670366481669, 6596.076549283098, 6610.834729131774, 6418.646974416405, 6548.410643042125, 6549.607023578588, 6549.934500654992, 6565.113709649196, 4053.2501487224886, 4901.142300097486, 4913.943502147038, 4920.7785649645675, 4922.458529561745, 4759.976200118995, 4884.291777692232, 4892.706437613737, 4914.508549145093, 4927.531884470987, 4825.131476334259, 4831.106245344605, 4837.201861692816, 4851.199552073904, 4878.560929516343, 4622.560856718606, 4748.501407352247, 4863.927041094369, 4872.512748725135, 4892.510748925115, 3683.797391143486, 4111.773852438115, 4123.195976784528, 4125.711200215986, 4133.503979522477, 6236.563440559163, 6270.118964310735, 6313.273973493061, 6316.9368306317265, 6326.9683651581445, 5389.434109418533, 5494.2582751328855, 5584.106542953108, 5666.0, 5682.51698605619, 5836.212111364954, 6811.284815094443, 6882.793516194472, 6908.689108990107, 6914.239433662293, 4652.697574657636, 4655.022445286494, 4658.208104622222, 4660.650451216138, 4667.766611669403, 5966.791162309299, 7073.610951397671, 7402.888956665654, 7416.480846340704, 7419.0, 4768.3085952536685, 4769.785359658824, 4772.976135119302, 4774.3793306870575, 4778.617710583145, 3993.3011722948368, 4048.4534587830267, 4838.975805120952, 4853.39332583427, 4855.223164293696, 5699.800506982318, 5704.372519022904, 5711.600187986801, 5715.142728590745, 5718.914216286759, 6757.255226454835, 7025.367716905503, 7059.71761129549, 7060.293970602898, 7074.575525468488, 1662.783838101039, 1681.327469012405, 1683.2677785163494, 1684.991575042117, 1685.612309168898, 1070.9518071686794, 1086.5056399338282, 1096.1504833753904, 1103.3049179017169, 1104.3870651788175, 6462.547621666438, 6480.31956644555, 6492.740290388331, 6508.056331831858, 6509.056186852879, 7237.6019318936915, 7245.710171593078, 7257.419406447471, 7266.92733072673, 7269.818254543678, 6273.749050038039, 6471.126397936312, 6476.676166191672, 6495.8700825983215, 6502.317256688074, 3861.416819104154, 3874.9418758718643, 3875.5349358076646, 3879.689624830007, 3896.2597106549665, 6110.541709371815, 7571.0, 7575.356094731899, 7578.924210757822, 7600.50596711212, 6074.54440916933, 7039.768040592876, 7306.342429181293, 7497.1003479581705, 7508.849823003509, 7675.194104619046, 7698.34564062061, 7709.691612335556, 7711.03612048494, 7735.265149810759, 7378.889316660147, 7386.482946193715, 7393.297636724503, 7398.630068496661, 7417.072865891763, 6163.599366041193, 6261.810256051335, 7219.891701624375, 7258.891116633149, 7260.2739726026975, 6084.847878803065, 7641.159472457914, 7653.464257501922, 7653.57905315213, 7653.846923061619, 4068.247374235776, 4410.7208909417195, 4592.448906131285, 4628.490866004669, 4635.096156249634, 7127.39286185544, 7193.208747037717, 7288.599127047851, 7294.635268236673, 7302.6713797878165, 7060.223375428802, 7070.646467676698, 7078.256783037707, 7084.22073571917, 7091.716331346688, 7045.1898031727005, 7048.788536343918, 7050.0129981801565, 7052.682629281797, 7061.1173603299585, 6698.162729658793, 6915.654217289216, 6954.235034146341, 6988.720451181895, 6995.335443132894, 7146.7141314346845, 7149.9285007149265, 7153.892691609734, 7161.892571611325, 7161.928380716126, 5632.5212356950115, 6747.325267473213, 6986.930130698628, 6992.475564332797, 7000.369966703021], "unit": "score", "name": "prototype.html", "value": 5117.390566022838}, {"lowerIsBetter": false, "replicates": [668.8695704337655, 686.1526015371016, 706.2302090721113, 730.3244498838579, 786.7718361675114, 14910.329035193416, 14967.101973881561, 15172.468963586276, 15173.620659483518, 15190.392384304641, 13909.304534773271, 13980.790288145661, 14006.439742410292, 14009.509667161627, 14014.859851401483, 578.8523926398783, 685.674304705266, 839.3159574946399, 849.9660013599464, 872.7469033980138, 861.28513333933, 868.2619773192798, 872.733816186063, 873.2620935309653, 876.6055275126187, 816.4692949582759, 911.3256190419108, 913.6117150211134, 915.6886658536097, 916.564631799893, 734.6547122852251, 741.4735537768191, 892.2683399612321, 909.3361845852498, 911.1344222988122, 669.6718607882151, 671.2549070531705, 672.2873753820966, 673.2257903411067, 674.0092064664934, 14761.33573989173, 14812.0, 14819.555413337617, 14821.851781482155, 14823.332950017168, 12791.360431978457, 12908.741825163444, 13007.414666340037, 13310.073528309074, 13519.053666243366, 10256.33333833306, 10417.947910260476, 10440.530176142092, 10545.209109316833, 10610.0, 3520.4719292106133, 3579.6062433132333, 3630.473581330719, 3646.4165733482782, 3660.560732712065, 83611.0, 84323.57838210832, 84563.99999999939, 84649.0, 84754.77673702931, 9231.907680923105, 9356.4386136832, 9423.528823558794, 9517.381370210915, 9527.761805954906, 16371.672566548841, 20045.79954200439, 20212.78723276608, 20410.795892041187, 20432.182712691327, 7447.776566703008, 7590.7722768317035, 7602.087749470099, 7661.080670319598, 7667.846643067219, 4014.638682518529, 4069.308217603015, 4071.5114186297833, 4094.9795251023556, 4110.34234522475, 3597.6222496638, 3636.4181730922924, 3642.417213245868, 3643.763155394891, 3645.3802853514967, 637.6206157336377, 650.6909218121355, 652.1456891472187, 672.5023482622823, 677.2448719677623, 530.2761730238198, 568.5451638689033, 568.7412227436589, 598.1147901106386, 635.5424094651843, 9127.908720912706, 9235.676751313671, 9261.30540209487, 9375.296852736072, 9423.057694230522, 613.6747523812387, 618.2735286038976, 627.1314229791681, 636.3795299582962, 636.920384951881, 3835.137094153793, 4270.42349282849, 4298.20483210607, 4363.432753741993, 4382.298832186835, 82423.0, 84383.73424398639, 86010.56994714987, 86121.0, 86122.0, 69649.65175174092, 69763.0, 69830.65084674544, 73835.0, 77059.61470192613, 64423.67788161123, 65247.0, 66004.67990640161, 66489.33510664832, 67417.66291168513, 8900.599473023858, 8902.554872256233, 8937.865932010895, 9020.097990200928, 9187.632494700138, 49831.501684984134, 50417.495825042744, 50785.0, 51689.48310516847, 51777.446676599764, 66294.67410651856, 67683.32316676967, 68657.65671171612, 69833.30166698471, 69996.0, 11085.22403431752, 11128.610498632508, 11310.547578096784, 11391.373474458984, 11532.308061516336, 11953.641390757943, 12108.455119519467, 12354.745561184016, 12571.245725256147, 12749.0, 11348.943255284, 11379.374134422686, 11491.425428728697, 11734.94132529332, 11995.220310679779, 11568.595099171489, 11569.595064172714, 11852.585159519376, 11935.52257909674, 12088.516459341528, 10350.327228730108, 10392.116670083127, 11272.9436352821, 11411.429428528707, 12282.201656892274, 9336.673216437392, 9375.484348360633, 9556.23550116003, 9673.0, 9901.0, 8200.83598328042, 8991.910080899108, 9117.0, 9335.906640933505, 9751.073648003428], "unit": "score", "name": "yui.html", "value": 6880.778422527282}], "name": "dromaeo_css", "value": 7455.693124083622}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [154.0, 155.0, 158.0, 109.0, 112.0, 113.0, 117.0, 111.0, 109.0, 109.0], "unit": "score", "name": "ai-astar", "value": 124.7}, {"lowerIsBetter": true, "replicates": [166.0, 123.0, 141.0, 155.0, 123.0, 141.0, 137.0, 121.0, 144.0, 149.0], "unit": "score", "name": "audio-beat-detection", "value": 140.0}, {"lowerIsBetter": true, "replicates": [185.0, 187.0, 186.0, 183.0, 185.0, 186.0, 183.0, 179.0, 163.0, 249.0], "unit": "score", "name": "audio-dft", "value": 188.6}, {"lowerIsBetter": true, "replicates": [76.0, 74.0, 83.0, 77.0, 60.0, 57.0, 58.0, 75.0, 77.0, 57.0], "unit": "score", "name": "audio-fft", "value": 69.4}, {"lowerIsBetter": true, "replicates": [91.0, 96.0, 125.0, 84.0, 116.0, 127.0, 110.0, 76.0, 78.0, 105.0], "unit": "score", "name": "audio-oscillator", "value": 100.8}, {"lowerIsBetter": true, "replicates": [86.0, 91.0, 85.0, 92.0, 85.0, 91.0, 85.0, 92.0, 85.0, 92.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 88.4}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 95.0, 94.0, 95.0, 94.0, 94.0, 93.0, 94.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 94.1}, {"lowerIsBetter": true, "replicates": [86.0, 85.0, 85.0, 87.0, 86.0, 87.0, 84.0, 86.0, 82.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 85.3}, {"lowerIsBetter": true, "replicates": [53.0, 54.0, 56.0, 55.0, 54.0, 52.0, 54.0, 63.0, 51.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 54.4}, {"lowerIsBetter": true, "replicates": [63.0, 70.0, 61.0, 77.0, 74.0, 71.0, 69.0, 66.0, 65.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 81.0, 82.0, 84.0, 95.0, 107.0, 109.0, 105.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 91.5}, {"lowerIsBetter": true, "replicates": [123.0, 125.0, 125.0, 127.0, 111.0, 126.0, 118.0, 123.0, 124.0, 152.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.4}, {"lowerIsBetter": true, "replicates": [128.0, 125.0, 140.0, 139.0, 137.0, 126.0, 136.0, 138.0, 138.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 134.4}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 66.0, 66.0, 66.0, 67.0, 66.0, 67.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.4}], "name": "kraken", "value": 1431.6000000000001}]} 16:57:37 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1431.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7455.69"}}} 16:57:37 INFO - Return code: 0 16:57:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:57:38 INFO - # TBPL SUCCESS # 16:57:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:57:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:57:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:57:38 INFO - 2016-02-15 16:57:38.040 screenresolution[1704:13892] starting screenresolution argv=screenresolution get 16:57:38 INFO - 2016-02-15 16:57:38.043 screenresolution[1704:13892] Display 0: 1600x1200x32@60 16:57:38 INFO - 2016-02-15 16:57:38.049 screenresolution[1705:13895] starting screenresolution argv=screenresolution list 16:57:38 INFO - Available Modes on Display 0 16:57:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:57:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:57:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:57:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:57:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:57:38 INFO - Intel Iris: 16:57:38 INFO - Chipset Model: Intel Iris 16:57:38 INFO - Type: GPU 16:57:38 INFO - Bus: Built-In 16:57:38 INFO - VRAM (Dynamic, Max): 1536 MB 16:57:38 INFO - Vendor: Intel (0x8086) 16:57:38 INFO - Device ID: 0x0a2e 16:57:38 INFO - Revision ID: 0x0009 16:57:38 INFO - Displays: 16:57:38 INFO - Display: 16:57:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:57:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:57:38 INFO - Display Serial Number: 1600x1200 60 16:57:38 INFO - Main Display: Yes 16:57:38 INFO - Mirror: Off 16:57:38 INFO - Online: Yes 16:57:38 INFO - Rotation: Supported 16:57:38 INFO - Return code: 0 16:57:38 INFO - Running post-action listener: _resource_record_post_action 16:57:38 INFO - Running post-run listener: _resource_record_post_run 16:57:39 INFO - Total resource usage - Wall time: 1208s; CPU: 52.0%; Read bytes: 33877504; Write bytes: 711162880; Read time: 348; Write time: 1917 16:57:39 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 404781568; Write bytes: 405784064; Read time: 30106; Write time: 739 16:57:39 INFO - run-tests - Wall time: 1174s; CPU: 52.0%; Read bytes: 32095744; Write bytes: 304530944; Read time: 330; Write time: 1176 16:57:39 INFO - Running post-run listener: _upload_blobber_files 16:57:39 INFO - Blob upload gear active. 16:57:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:57:39 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:57:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:57:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:57:39 INFO - (blobuploader) - INFO - Open directory for files ... 16:57:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:57:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:57:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:57:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:57:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:57:40 INFO - (blobuploader) - INFO - Done attempting. 16:57:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:57:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:57:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:57:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:57:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:57:41 INFO - (blobuploader) - INFO - Done attempting. 16:57:41 INFO - (blobuploader) - INFO - Iteration through files over. 16:57:41 INFO - Return code: 0 16:57:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:57:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:57:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2d37f9c65c0d52787867dd24fc17a7861a95169a348313b309e58a5139827304ff79c31a2e392ef8525ab957b703e06757af5f60f9f6f2b36322b1e78666b90a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/04f8b56e652dcc90395950923a9df1ca0c41970065e50540f017c469b949b5d7f2381f5746eef24ccb0aba19c8e7592e7ccd79c9a569aa752ffc751cb27156e5"} 16:57:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:57:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:57:41 INFO - Contents: 16:57:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2d37f9c65c0d52787867dd24fc17a7861a95169a348313b309e58a5139827304ff79c31a2e392ef8525ab957b703e06757af5f60f9f6f2b36322b1e78666b90a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/04f8b56e652dcc90395950923a9df1ca0c41970065e50540f017c469b949b5d7f2381f5746eef24ccb0aba19c8e7592e7ccd79c9a569aa752ffc751cb27156e5"} 16:57:41 INFO - Running post-run listener: copy_logs_to_upload_dir 16:57:41 INFO - Copying logs to upload dir... 16:57:41 INFO - mkdir: /builds/slave/test/build/upload/logs 16:57:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1298.431616 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 38 secs) (at 2016-02-15 16:57:41.610335) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-15 16:57:41.613761) ========= 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.wxYbj8eaYE/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.vFBr68d91O/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2d37f9c65c0d52787867dd24fc17a7861a95169a348313b309e58a5139827304ff79c31a2e392ef8525ab957b703e06757af5f60f9f6f2b36322b1e78666b90a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/04f8b56e652dcc90395950923a9df1ca0c41970065e50540f017c469b949b5d7f2381f5746eef24ccb0aba19c8e7592e7ccd79c9a569aa752ffc751cb27156e5"} build_url:https://queue.taskcluster.net/v1/task/B_mrhWg7TwCluTaeHAsmCg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010963 build_url: 'https://queue.taskcluster.net/v1/task/B_mrhWg7TwCluTaeHAsmCg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2d37f9c65c0d52787867dd24fc17a7861a95169a348313b309e58a5139827304ff79c31a2e392ef8525ab957b703e06757af5f60f9f6f2b36322b1e78666b90a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/04f8b56e652dcc90395950923a9df1ca0c41970065e50540f017c469b949b5d7f2381f5746eef24ccb0aba19c8e7592e7ccd79c9a569aa752ffc751cb27156e5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-15 16:57:41.642703) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 16:57:41.643327) ========= 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.wxYbj8eaYE/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.vFBr68d91O/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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.005302 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 16:57:41.696185) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-15 16:57:41.696914) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-15 16:57:41.697809) ========= ========= Total master_lag: 0.41 =========