builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0102 starttime: 1458326853.93 results: success (0) buildid: 20160318092810 builduid: 794c4954cc7e45419facfc841f7bdc41 revision: dbba8191f3c1e22505f5e5d5b8537f719eafb51d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-18 11:47:33.934481) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-18 11:47:33.934937) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-18 11:47:33.935222) ========= 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.0N1Y1L62Ke/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.noqIWM6oJS/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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.005870 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-18 11:47:33.959588) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-18 11:47:33.959866) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-18 11:47:34.149094) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 11:47:34.149936) ========= 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.0N1Y1L62Ke/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.noqIWM6oJS/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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.005406 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 11:47:34.199849) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-18 11:47:34.200186) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-18 11:47:34.200520) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 11:47:34.200806) ========= 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.0N1Y1L62Ke/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.noqIWM6oJS/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-18 11:47:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.07M=0.002s 2016-03-18 11:47:34 (7.07 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.160648 ========= master_lag: 0.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 11:47:34.451484) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 11:47:34.451771) ========= 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.0N1Y1L62Ke/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.noqIWM6oJS/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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.019866 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 11:47:34.500477) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-18 11:47:34.500870) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev dbba8191f3c1e22505f5e5d5b8537f719eafb51d --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 dbba8191f3c1e22505f5e5d5b8537f719eafb51d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0N1Y1L62Ke/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.noqIWM6oJS/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-18 11:47:34,573 truncating revision to first 12 chars 2016-03-18 11:47:34,573 Setting DEBUG logging. 2016-03-18 11:47:34,574 attempt 1/10 2016-03-18 11:47:34,574 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/dbba8191f3c1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-18 11:47:35,782 unpacking tar archive at: fx-team-dbba8191f3c1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.453087 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-18 11:47:35.972053) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-18 11:47:35.972440) ========= echo dbba8191f3c1e22505f5e5d5b8537f719eafb51d in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'dbba8191f3c1e22505f5e5d5b8537f719eafb51d'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0N1Y1L62Ke/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.noqIWM6oJS/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 dbba8191f3c1e22505f5e5d5b8537f719eafb51d program finished with exit code 0 elapsedTime=0.004544 script_repo_revision: 'dbba8191f3c1e22505f5e5d5b8537f719eafb51d' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-18 11:47:36.026653) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-18 11:47:36.027400) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-18 11:47:36.042471) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-03-18 11:47:36.042875) ========= /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.0N1Y1L62Ke/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.noqIWM6oJS/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 11:47:36 INFO - MultiFileLogger online at 20160318 11:47:36 in /builds/slave/test 11:47:36 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 11:47:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:47:36 INFO - {'append_to_log': False, 11:47:36 INFO - 'base_work_dir': '/builds/slave/test', 11:47:36 INFO - 'blob_upload_branch': 'Fx-Team', 11:47:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:47:36 INFO - 'branch': 'Fx-Team', 11:47:36 INFO - 'buildbot_json_path': 'buildprops.json', 11:47:36 INFO - 'config_files': ('talos/mac_config.py',), 11:47:36 INFO - 'default_actions': ('clobber', 11:47:36 INFO - 'read-buildbot-config', 11:47:36 INFO - 'download-and-extract', 11:47:36 INFO - 'populate-webroot', 11:47:36 INFO - 'create-virtualenv', 11:47:36 INFO - 'install', 11:47:36 INFO - 'run-tests'), 11:47:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:47:36 INFO - 'download_minidump_stackwalk': True, 11:47:36 INFO - 'download_symbols': 'ondemand', 11:47:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:47:36 INFO - 'tooltool.py': '/tools/tooltool.py', 11:47:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:47:36 INFO - '/tools/misc-python/virtualenv.py')}, 11:47:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:47:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:47:36 INFO - 'installer_path': 'installer.exe', 11:47:36 INFO - 'log_level': 'info', 11:47:36 INFO - 'log_name': 'talos', 11:47:36 INFO - 'log_to_console': True, 11:47:36 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:47:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:47:36 INFO - 'opt_config_files': (), 11:47:36 INFO - 'pip_index': False, 11:47:36 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:47:36 INFO - 'cmd': ('bash', 11:47:36 INFO - '-c', 11:47:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:47:36 INFO - 'enabled': True, 11:47:36 INFO - 'halt_on_failure': False, 11:47:36 INFO - 'name': 'check_screen_resolution'},), 11:47:36 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:47:36 INFO - 'cmd': ('bash', 11:47:36 INFO - '-c', 11:47:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:47:36 INFO - 'enabled': True, 11:47:36 INFO - 'halt_on_failure': False, 11:47:36 INFO - 'name': 'check_screen_resolution'},), 11:47:36 INFO - 'run_cmd_checks_enabled': True, 11:47:36 INFO - 'sps_profile': False, 11:47:36 INFO - 'sps_profile_interval': 0, 11:47:36 INFO - 'suite': 'dromaeojs', 11:47:36 INFO - 'system_bits': '32', 11:47:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:47:36 INFO - 'title': 't-yosemite-r7-0102', 11:47:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:47:36 INFO - 'use_talos_json': True, 11:47:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:47:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:47:36 INFO - 'work_dir': 'build'} 11:47:36 INFO - ##### 11:47:36 INFO - ##### Running clobber step. 11:47:36 INFO - ##### 11:47:36 INFO - Running pre-action listener: _resource_record_pre_action 11:47:36 INFO - Running main action method: clobber 11:47:36 INFO - rmtree: /builds/slave/test/build 11:47:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:47:37 INFO - Running post-action listener: _resource_record_post_action 11:47:37 INFO - ##### 11:47:37 INFO - ##### Running read-buildbot-config step. 11:47:37 INFO - ##### 11:47:37 INFO - Running pre-action listener: _resource_record_pre_action 11:47:37 INFO - Running main action method: read_buildbot_config 11:47:37 INFO - Using buildbot properties: 11:47:37 INFO - { 11:47:37 INFO - "project": "", 11:47:37 INFO - "product": "firefox", 11:47:37 INFO - "script_repo_revision": "production", 11:47:37 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 11:47:37 INFO - "repository": "", 11:47:37 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 11:47:37 INFO - "buildid": "20160318092810", 11:47:37 INFO - "pgo_build": "False", 11:47:37 INFO - "basedir": "/builds/slave/test", 11:47:37 INFO - "buildnumber": 549, 11:47:37 INFO - "slavename": "t-yosemite-r7-0102", 11:47:37 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 11:47:37 INFO - "platform": "yosemite_r7", 11:47:37 INFO - "scheduler": "tests-fx-team-macosx64-talos", 11:47:37 INFO - "branch": "fx-team", 11:47:37 INFO - "repo_path": "integration/fx-team", 11:47:37 INFO - "revision": "dbba8191f3c1e22505f5e5d5b8537f719eafb51d", 11:47:37 INFO - "stage_platform": "macosx64", 11:47:37 INFO - "builduid": "794c4954cc7e45419facfc841f7bdc41", 11:47:37 INFO - "slavebuilddir": "test" 11:47:37 INFO - } 11:47:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/XTG0GOXhSASlgG41JAt3Ag/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 11:47:37 INFO - Running post-action listener: _resource_record_post_action 11:47:37 INFO - ##### 11:47:37 INFO - ##### Running download-and-extract step. 11:47:37 INFO - ##### 11:47:37 INFO - Running pre-action listener: _resource_record_pre_action 11:47:37 INFO - Running main action method: download_and_extract 11:47:37 INFO - mkdir: /builds/slave/test/build/tests 11:47:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:47:37 INFO - https://queue.taskcluster.net/v1/task/XTG0GOXhSASlgG41JAt3Ag/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 11:47:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XTG0GOXhSASlgG41JAt3Ag/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 11:47:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XTG0GOXhSASlgG41JAt3Ag/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 11:47:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XTG0GOXhSASlgG41JAt3Ag/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 11:47:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XTG0GOXhSASlgG41JAt3Ag/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 11:47:39 INFO - Downloaded 1199 bytes. 11:47:39 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 11:47:39 INFO - Using the following test package requirements: 11:47:39 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 11:47:39 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:47:39 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 11:47:39 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:47:39 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 11:47:39 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:47:39 INFO - u'jsshell-mac.zip'], 11:47:39 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:47:39 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 11:47:39 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 11:47:39 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:47:39 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 11:47:39 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:47:39 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 11:47:39 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:47:39 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 11:47:39 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:47:39 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 11:47:39 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:47:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:47:39 INFO - https://queue.taskcluster.net/v1/task/XTG0GOXhSASlgG41JAt3Ag/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:47:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XTG0GOXhSASlgG41JAt3Ag/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 11:47:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XTG0GOXhSASlgG41JAt3Ag/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 11:47:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XTG0GOXhSASlgG41JAt3Ag/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 11:47:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XTG0GOXhSASlgG41JAt3Ag/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:47:40 INFO - Downloaded 17871399 bytes. 11:47:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:47:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 11:47:43 INFO - Return code: 0 11:47:43 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 11:47:43 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')]} 11:47:43 INFO - https://queue.taskcluster.net/v1/task/XTG0GOXhSASlgG41JAt3Ag/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:47:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XTG0GOXhSASlgG41JAt3Ag/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 11:47:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XTG0GOXhSASlgG41JAt3Ag/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 11:47:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XTG0GOXhSASlgG41JAt3Ag/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 11:47:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XTG0GOXhSASlgG41JAt3Ag/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:47:45 INFO - Downloaded 17871399 bytes. 11:47:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:47:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 11:47:48 INFO - Return code: 0 11:47:48 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')]} 11:47:48 INFO - https://queue.taskcluster.net/v1/task/XTG0GOXhSASlgG41JAt3Ag/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 11:47:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XTG0GOXhSASlgG41JAt3Ag/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 11:47:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XTG0GOXhSASlgG41JAt3Ag/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 11:47:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XTG0GOXhSASlgG41JAt3Ag/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 11:47:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XTG0GOXhSASlgG41JAt3Ag/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 11:47:49 INFO - Downloaded 10846565 bytes. 11:47:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:47:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 11:47:50 INFO - Return code: 0 11:47: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')]} 11:47:50 INFO - https://queue.taskcluster.net/v1/task/XTG0GOXhSASlgG41JAt3Ag/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 11:47:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XTG0GOXhSASlgG41JAt3Ag/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 11:47:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XTG0GOXhSASlgG41JAt3Ag/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 11:47:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XTG0GOXhSASlgG41JAt3Ag/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 11:47:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XTG0GOXhSASlgG41JAt3Ag/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 11:47:56 INFO - Downloaded 111199811 bytes. 11:47:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XTG0GOXhSASlgG41JAt3Ag/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 11:47:56 INFO - mkdir: /builds/slave/test/properties 11:47:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:47:56 INFO - Writing to file /builds/slave/test/properties/build_url 11:47:56 INFO - Contents: 11:47:56 INFO - build_url:https://queue.taskcluster.net/v1/task/XTG0GOXhSASlgG41JAt3Ag/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 11:47:57 INFO - Running post-action listener: _resource_record_post_action 11:47:57 INFO - Running post-action listener: set_extra_try_arguments 11:47:57 INFO - ##### 11:47:57 INFO - ##### Running populate-webroot step. 11:47:57 INFO - ##### 11:47:57 INFO - Running pre-action listener: _resource_record_pre_action 11:47:57 INFO - Running main action method: populate_webroot 11:47:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:47:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:47:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:47:57 INFO - '--tppagecycles', 11:47:57 INFO - '7'], 11:47:57 INFO - 'tests': ['tsvgm']}}, 11:47:57 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:47:57 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:47:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:47:57 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 11:47:57 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:47:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:47:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:47:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:47:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:47:57 INFO - 'talos_options': ['--e10s'], 11:47:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:47:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:47:57 INFO - 'tests': ['damp', 'tps']}, 11:47:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:47:57 INFO - 'talos_options': ['--e10s'], 11:47:57 INFO - 'tests': ['damp', 'tps']}, 11:47:57 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:47:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:47:57 INFO - 'other': {'tests': ['a11yr', 11:47:57 INFO - 'ts_paint', 11:47:57 INFO - 'tpaint', 11:47:57 INFO - 'sessionrestore', 11:47:57 INFO - 'sessionrestore_no_auto_restore', 11:47:57 INFO - 'tabpaint']}, 11:47:57 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:47:57 INFO - 'tests': ['a11yr', 11:47:57 INFO - 'ts_paint', 11:47:57 INFO - 'tpaint', 11:47:57 INFO - 'sessionrestore', 11:47:57 INFO - 'sessionrestore_no_auto_restore', 11:47:57 INFO - 'tabpaint']}, 11:47:57 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:47:57 INFO - 'tests': ['a11yr', 11:47:57 INFO - 'ts_paint', 11:47:57 INFO - 'tpaint', 11:47:57 INFO - 'sessionrestore', 11:47:57 INFO - 'sessionrestore_no_auto_restore', 11:47:57 INFO - 'tabpaint']}, 11:47:57 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:47:57 INFO - 'tests': ['a11yr', 11:47:57 INFO - 'ts_paint', 11:47:57 INFO - 'tpaint', 11:47:57 INFO - 'sessionrestore', 11:47:57 INFO - 'sessionrestore_no_auto_restore', 11:47:57 INFO - 'tabpaint']}, 11:47:57 INFO - 'other_l64': {'tests': ['a11yr', 11:47:57 INFO - 'ts_paint', 11:47:57 INFO - 'tpaint', 11:47:57 INFO - 'sessionrestore', 11:47:57 INFO - 'sessionrestore_no_auto_restore', 11:47:57 INFO - 'tabpaint']}, 11:47:57 INFO - 'other_nol64': {'tests': ['a11yr', 11:47:57 INFO - 'ts_paint', 11:47:57 INFO - 'tpaint', 11:47:57 INFO - 'sessionrestore', 11:47:57 INFO - 'sessionrestore_no_auto_restore', 11:47:57 INFO - 'tabpaint']}, 11:47:57 INFO - 'svgr': {'tests': ['tsvgx', 11:47:57 INFO - 'tsvgr_opacity', 11:47:57 INFO - 'tart', 11:47:57 INFO - 'tscrollx', 11:47:57 INFO - 'cart']}, 11:47:57 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:47:57 INFO - 'tests': ['tsvgx', 11:47:57 INFO - 'tsvgr_opacity', 11:47:57 INFO - 'tart', 11:47:57 INFO - 'tscrollx', 11:47:57 INFO - 'cart']}, 11:47:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:47:57 INFO - 'tests': ['tp5o']}, 11:47:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:47:57 INFO - 'talos_options': ['--e10s'], 11:47:57 INFO - 'tests': ['tp5o']}, 11:47:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:47:57 INFO - 'talos_options': ['--xperf_path', 11:47:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:47:57 INFO - 'tests': ['tp5n']}, 11:47:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:47:57 INFO - 'talos_options': ['--e10s', 11:47:57 INFO - '--xperf_path', 11:47:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:47:57 INFO - 'tests': ['tp5n']}}, 11:47:57 INFO - 'talos.zip': {'path': '', 11:47:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:47:57 INFO - Running post-action listener: _resource_record_post_action 11:47:57 INFO - ##### 11:47:57 INFO - ##### Running create-virtualenv step. 11:47:57 INFO - ##### 11:47:57 INFO - Running pre-action listener: _resource_record_pre_action 11:47:57 INFO - Running main action method: create_virtualenv 11:47:57 INFO - Creating virtualenv /builds/slave/test/build/venv 11:47:57 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 11:47:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:47:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:47:57 INFO - Using real prefix '/tools/python27' 11:47:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:47:58 INFO - Installing distribute.............................................................................................................................................................................................done. 11:48:01 INFO - Installing pip.................done. 11:48:01 INFO - Return code: 0 11:48:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:48:01 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')]} 11:48:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:01 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')]} 11:48:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:01 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 0x10438ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10439b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefeb497960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10422ae00>, '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 0x104053db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104225b20>, '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.0N1Y1L62Ke/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.noqIWM6oJS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 11:48:01 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 11:48:01 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 11:48:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0N1Y1L62Ke/Render', 11:48:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:48:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:48:01 INFO - 'HOME': '/Users/cltbld', 11:48:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:48:01 INFO - 'LOGNAME': 'cltbld', 11:48:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:01 INFO - 'MOZ_NO_REMOTE': '1', 11:48:01 INFO - 'NO_EM_RESTART': '1', 11:48:01 INFO - 'PAGER': '/bin/cat', 11:48:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:48:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:01 INFO - 'PWD': '/builds/slave/test', 11:48:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:48:01 INFO - 'SHELL': '/bin/bash', 11:48:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.noqIWM6oJS/Listeners', 11:48:01 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 11:48:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:48:01 INFO - 'USER': 'cltbld', 11:48:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:48:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:48:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:01 INFO - 'XPC_FLAGS': '0x0', 11:48:01 INFO - 'XPC_SERVICE_NAME': '0', 11:48:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:48:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:01 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 11:48:01 INFO - Cleaning up... 11:48:01 INFO - Return code: 0 11:48:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:48:01 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')]} 11:48:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:01 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')]} 11:48:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:01 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 0x10438ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10439b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefeb497960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10422ae00>, '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 0x104053db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104225b20>, '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.0N1Y1L62Ke/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.noqIWM6oJS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 11:48:01 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 11:48:01 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 11:48:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0N1Y1L62Ke/Render', 11:48:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:48:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:48:01 INFO - 'HOME': '/Users/cltbld', 11:48:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:48:01 INFO - 'LOGNAME': 'cltbld', 11:48:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:01 INFO - 'MOZ_NO_REMOTE': '1', 11:48:01 INFO - 'NO_EM_RESTART': '1', 11:48:01 INFO - 'PAGER': '/bin/cat', 11:48:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:48:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:01 INFO - 'PWD': '/builds/slave/test', 11:48:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:48:01 INFO - 'SHELL': '/bin/bash', 11:48:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.noqIWM6oJS/Listeners', 11:48:01 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 11:48:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:48:01 INFO - 'USER': 'cltbld', 11:48:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:48:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:48:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:01 INFO - 'XPC_FLAGS': '0x0', 11:48:01 INFO - 'XPC_SERVICE_NAME': '0', 11:48:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:48:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:01 INFO - Downloading/unpacking psutil>=0.7.1 11:48:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:48:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:48:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:48:04 INFO - Installing collected packages: psutil 11:48:04 INFO - Running setup.py install for psutil 11:48:04 INFO - building 'psutil._psutil_osx' extension 11:48:04 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 11:48:05 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 11:48:05 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 11:48:05 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 11:48:05 INFO - building 'psutil._psutil_posix' extension 11:48:05 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 11:48:05 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:48:05 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:48:05 INFO - ^ 11:48:05 INFO - 1 warning generated. 11:48:05 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 11:48:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:48:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:48:05 INFO - Successfully installed psutil 11:48:05 INFO - Cleaning up... 11:48:05 INFO - Return code: 0 11:48:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:48:05 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')]} 11:48:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:05 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')]} 11:48:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:05 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 0x10438ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10439b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefeb497960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10422ae00>, '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 0x104053db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104225b20>, '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.0N1Y1L62Ke/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.noqIWM6oJS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 11:48:05 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 11:48:05 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 11:48:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0N1Y1L62Ke/Render', 11:48:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:48:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:48:05 INFO - 'HOME': '/Users/cltbld', 11:48:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:48:05 INFO - 'LOGNAME': 'cltbld', 11:48:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:05 INFO - 'MOZ_NO_REMOTE': '1', 11:48:05 INFO - 'NO_EM_RESTART': '1', 11:48:05 INFO - 'PAGER': '/bin/cat', 11:48:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:48:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:05 INFO - 'PWD': '/builds/slave/test', 11:48:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:48:05 INFO - 'SHELL': '/bin/bash', 11:48:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.noqIWM6oJS/Listeners', 11:48:05 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 11:48:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:48:05 INFO - 'USER': 'cltbld', 11:48:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:48:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:48:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:05 INFO - 'XPC_FLAGS': '0x0', 11:48:05 INFO - 'XPC_SERVICE_NAME': '0', 11:48:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:48:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:48:05 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 11:48:05 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 11:48:05 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 11:48:05 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 11:48:05 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 11:48:05 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 11:48:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:48:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:48:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:48:08 INFO - Installing collected packages: mozsystemmonitor 11:48:08 INFO - Running setup.py install for mozsystemmonitor 11:48:08 INFO - Successfully installed mozsystemmonitor 11:48:08 INFO - Cleaning up... 11:48:08 INFO - Return code: 0 11:48:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:48:08 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')]} 11:48:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:08 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')]} 11:48:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:08 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 0x10438ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10439b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefeb497960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10422ae00>, '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 0x104053db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104225b20>, '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.0N1Y1L62Ke/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.noqIWM6oJS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 11:48:08 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 11:48:08 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 11:48:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0N1Y1L62Ke/Render', 11:48:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:48:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:48:08 INFO - 'HOME': '/Users/cltbld', 11:48:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:48:08 INFO - 'LOGNAME': 'cltbld', 11:48:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:08 INFO - 'MOZ_NO_REMOTE': '1', 11:48:08 INFO - 'NO_EM_RESTART': '1', 11:48:08 INFO - 'PAGER': '/bin/cat', 11:48:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:48:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:08 INFO - 'PWD': '/builds/slave/test', 11:48:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:48:08 INFO - 'SHELL': '/bin/bash', 11:48:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.noqIWM6oJS/Listeners', 11:48:08 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 11:48:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:48:08 INFO - 'USER': 'cltbld', 11:48:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:48:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:48:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:08 INFO - 'XPC_FLAGS': '0x0', 11:48:08 INFO - 'XPC_SERVICE_NAME': '0', 11:48:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:48:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:08 INFO - Downloading/unpacking blobuploader==1.2.4 11:48:08 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 11:48:08 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 11:48:08 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 11:48:08 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 11:48:08 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 11:48:08 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 11:48:11 INFO - Downloading blobuploader-1.2.4.tar.gz 11:48:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:48:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:48:11 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 11:48:11 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 11:48:11 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 11:48:11 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 11:48:11 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 11:48:11 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 11:48:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:48:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:48:11 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 11:48:11 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 11:48:11 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 11:48:11 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 11:48:11 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 11:48:11 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 11:48:12 INFO - Downloading docopt-0.6.1.tar.gz 11:48:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:48:12 INFO - Installing collected packages: blobuploader, requests, docopt 11:48:12 INFO - Running setup.py install for blobuploader 11:48:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:48:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:48:12 INFO - Running setup.py install for requests 11:48:13 INFO - Running setup.py install for docopt 11:48:13 INFO - Successfully installed blobuploader requests docopt 11:48:13 INFO - Cleaning up... 11:48:13 INFO - Return code: 0 11:48:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:48:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:48:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:13 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 0x10438ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10439b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefeb497960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10422ae00>, '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 0x104053db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104225b20>, '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.0N1Y1L62Ke/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.noqIWM6oJS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 11:48:13 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 11:48:13 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 11:48:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0N1Y1L62Ke/Render', 11:48:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:48:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:48:13 INFO - 'HOME': '/Users/cltbld', 11:48:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:48:13 INFO - 'LOGNAME': 'cltbld', 11:48:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:13 INFO - 'MOZ_NO_REMOTE': '1', 11:48:13 INFO - 'NO_EM_RESTART': '1', 11:48:13 INFO - 'PAGER': '/bin/cat', 11:48:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:48:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:13 INFO - 'PWD': '/builds/slave/test', 11:48:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:48:13 INFO - 'SHELL': '/bin/bash', 11:48:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.noqIWM6oJS/Listeners', 11:48:13 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 11:48:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:48:13 INFO - 'USER': 'cltbld', 11:48:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:48:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:48:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:13 INFO - 'XPC_FLAGS': '0x0', 11:48:13 INFO - 'XPC_SERVICE_NAME': '0', 11:48:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:48:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:48:13 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-Ru4Ijp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:48:13 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-WFmV85-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:48:13 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-kfYokG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:48:14 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-lKSxxj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:48:14 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-E21TuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:48:14 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-7QnHt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:48:14 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-_sKYjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:48:14 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-SAHrPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:48:14 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-BAYt3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:48:14 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-wXmWxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:48:14 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-RkCR2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:48:14 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-JIwJqM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:48:14 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-65D3X7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:48:15 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-gHC79J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:48:15 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-5_Clan-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:48:15 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-BKeKxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:48:15 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-575MEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:48:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:48:15 INFO - Running setup.py install for manifestparser 11:48:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:48:15 INFO - Running setup.py install for mozcrash 11:48:15 INFO - Running setup.py install for mozdebug 11:48:15 INFO - Running setup.py install for mozdevice 11:48:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:48:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:48:16 INFO - Running setup.py install for mozfile 11:48:16 INFO - Running setup.py install for mozhttpd 11:48:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:48:16 INFO - Running setup.py install for mozinfo 11:48:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:48:16 INFO - Running setup.py install for mozInstall 11:48:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:48:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:48:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:48:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:48:16 INFO - Running setup.py install for mozleak 11:48:16 INFO - Running setup.py install for mozlog 11:48:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:48:17 INFO - Running setup.py install for moznetwork 11:48:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:48:17 INFO - Running setup.py install for mozprocess 11:48:17 INFO - Running setup.py install for mozprofile 11:48:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:48:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:48:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:48:17 INFO - Running setup.py install for mozrunner 11:48:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:48:17 INFO - Running setup.py install for mozscreenshot 11:48:17 INFO - Running setup.py install for moztest 11:48:17 INFO - Running setup.py install for mozversion 11:48:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:48:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:48:18 INFO - Cleaning up... 11:48:18 INFO - Return code: 0 11:48:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:48:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:48:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:48:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:18 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 0x10438ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10439b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefeb497960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10422ae00>, '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 0x104053db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104225b20>, '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.0N1Y1L62Ke/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.noqIWM6oJS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 11:48:18 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 11:48:18 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 11:48:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0N1Y1L62Ke/Render', 11:48:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:48:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:48:18 INFO - 'HOME': '/Users/cltbld', 11:48:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:48:18 INFO - 'LOGNAME': 'cltbld', 11:48:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:18 INFO - 'MOZ_NO_REMOTE': '1', 11:48:18 INFO - 'NO_EM_RESTART': '1', 11:48:18 INFO - 'PAGER': '/bin/cat', 11:48:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:48:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:18 INFO - 'PWD': '/builds/slave/test', 11:48:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:48:18 INFO - 'SHELL': '/bin/bash', 11:48:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.noqIWM6oJS/Listeners', 11:48:18 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 11:48:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:48:18 INFO - 'USER': 'cltbld', 11:48:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:48:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:48:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:18 INFO - 'XPC_FLAGS': '0x0', 11:48:18 INFO - 'XPC_SERVICE_NAME': '0', 11:48:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:48:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:48:18 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-wineP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:48:18 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)) 11:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:48:18 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-lFqz6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:48:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:48:18 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-vT665X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:48:18 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)) 11:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:48:18 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-NiXXsi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:48:18 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)) 11:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:48:18 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-WXnFCg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:48:18 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)) 11:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:48:18 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-GZkQb4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:48:19 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)) 11:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:48:19 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-VrnQzP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:48:19 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)) 11:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:48:19 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-LifAaR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:48:19 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)) 11:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:48:19 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-QjI9j6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:48:19 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)) 11:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:48:19 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-ErwAgR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:48:19 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)) 11:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:48:19 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-Gx9fKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:48:19 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)) 11:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:48:19 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-kfpNMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:48:19 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)) 11:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:48:19 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-OQBlZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:48:19 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)) 11:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:48:19 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-cdCx8q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:48:19 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)) 11:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:48:19 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-xhOUDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:48:20 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)) 11:48:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:48:20 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-_6aPJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:48:20 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)) 11:48:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:48:20 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-w3mEzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:48:20 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)) 11:48:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:48:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:48:20 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)) 11:48:20 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)) 11:48:20 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)) 11:48:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:48:20 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 11:48:20 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 11:48:20 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 11:48:20 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 11:48:20 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 11:48:20 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 11:48:23 INFO - Downloading blessings-1.6.tar.gz 11:48:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:48:23 INFO - Installing collected packages: blessings 11:48:23 INFO - Running setup.py install for blessings 11:48:23 INFO - Successfully installed blessings 11:48:23 INFO - Cleaning up... 11:48:23 INFO - Return code: 0 11:48:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:48:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:48:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:48:23 INFO - Reading from file tmpfile_stdout 11:48:23 INFO - Current package versions: 11:48:23 INFO - blessings == 1.6 11:48:23 INFO - blobuploader == 1.2.4 11:48:23 INFO - docopt == 0.6.1 11:48:23 INFO - manifestparser == 1.1 11:48:23 INFO - mozInstall == 1.12 11:48:23 INFO - mozcrash == 0.17 11:48:23 INFO - mozdebug == 0.1 11:48:23 INFO - mozdevice == 0.48 11:48:23 INFO - mozfile == 1.2 11:48:23 INFO - mozhttpd == 0.7 11:48:23 INFO - mozinfo == 0.9 11:48:23 INFO - mozleak == 0.1 11:48:23 INFO - mozlog == 3.1 11:48:23 INFO - moznetwork == 0.27 11:48:23 INFO - mozprocess == 0.22 11:48:23 INFO - mozprofile == 0.28 11:48:23 INFO - mozrunner == 6.11 11:48:23 INFO - mozscreenshot == 0.1 11:48:23 INFO - mozsystemmonitor == 0.0 11:48:23 INFO - moztest == 0.7 11:48:23 INFO - mozversion == 1.4 11:48:23 INFO - psutil == 3.1.1 11:48:23 INFO - requests == 1.2.3 11:48:23 INFO - wsgiref == 0.1.2 11:48:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:48:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:48:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:48:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:23 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 0x10438ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10439b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefeb497960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10422ae00>, '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 0x104053db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104225b20>, '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.0N1Y1L62Ke/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.noqIWM6oJS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 11:48:23 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 11:48:23 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 11:48:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0N1Y1L62Ke/Render', 11:48:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:48:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:48:23 INFO - 'HOME': '/Users/cltbld', 11:48:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:48:23 INFO - 'LOGNAME': 'cltbld', 11:48:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:23 INFO - 'MOZ_NO_REMOTE': '1', 11:48:23 INFO - 'NO_EM_RESTART': '1', 11:48:23 INFO - 'PAGER': '/bin/cat', 11:48:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:48:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:23 INFO - 'PWD': '/builds/slave/test', 11:48:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:48:23 INFO - 'SHELL': '/bin/bash', 11:48:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.noqIWM6oJS/Listeners', 11:48:23 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 11:48:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:48:23 INFO - 'USER': 'cltbld', 11:48:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:48:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:48:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:23 INFO - 'XPC_FLAGS': '0x0', 11:48:23 INFO - 'XPC_SERVICE_NAME': '0', 11:48:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:48:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:24 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)) 11:48:24 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)) 11:48:24 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)) 11:48:24 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)) 11:48:24 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)) 11:48:24 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)) 11:48:24 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)) 11:48:24 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)) 11:48:24 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)) 11:48:24 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)) 11:48:24 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)) 11:48:24 INFO - Cleaning up... 11:48:24 INFO - Return code: 0 11:48:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:48:24 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')]} 11:48:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:24 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')]} 11:48:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:24 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 0x10438ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10439b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefeb497960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10422ae00>, '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 0x104053db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104225b20>, '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.0N1Y1L62Ke/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.noqIWM6oJS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 11:48:24 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 11:48:24 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 11:48:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0N1Y1L62Ke/Render', 11:48:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:48:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:48:24 INFO - 'HOME': '/Users/cltbld', 11:48:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:48:24 INFO - 'LOGNAME': 'cltbld', 11:48:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:24 INFO - 'MOZ_NO_REMOTE': '1', 11:48:24 INFO - 'NO_EM_RESTART': '1', 11:48:24 INFO - 'PAGER': '/bin/cat', 11:48:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:48:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:24 INFO - 'PWD': '/builds/slave/test', 11:48:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:48:24 INFO - 'SHELL': '/bin/bash', 11:48:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.noqIWM6oJS/Listeners', 11:48:24 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 11:48:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:48:24 INFO - 'USER': 'cltbld', 11:48:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:48:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:48:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:24 INFO - 'XPC_FLAGS': '0x0', 11:48:24 INFO - 'XPC_SERVICE_NAME': '0', 11:48:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:48:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:24 INFO - Downloading/unpacking jsonschema 11:48: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 11:48: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 11:48: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 11:48: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 11:48: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 11:48: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 11:48:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:48:26 INFO - Downloading/unpacking functools32 (from jsonschema) 11:48:26 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 11:48:26 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 11:48:26 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 11:48:26 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 11:48:26 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 11:48:26 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 11:48:27 INFO - Downloading functools32-3.2.3-2.tar.gz 11:48:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:48:27 INFO - warning: no files found matching '*.txt' 11:48:27 INFO - no previously-included directories found matching 'build' 11:48:27 INFO - no previously-included directories found matching 'dist' 11:48:27 INFO - no previously-included directories found matching '.git*' 11:48:27 INFO - Installing collected packages: jsonschema, functools32 11:48:27 INFO - Running setup.py install for functools32 11:48:27 INFO - warning: no files found matching '*.txt' 11:48:27 INFO - no previously-included directories found matching 'build' 11:48:27 INFO - no previously-included directories found matching 'dist' 11:48:27 INFO - no previously-included directories found matching '.git*' 11:48:27 INFO - Successfully installed jsonschema functools32 11:48:27 INFO - Cleaning up... 11:48:27 INFO - Return code: 0 11:48:27 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:48:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:48:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:27 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 0x10438ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10439b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefeb497960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10422ae00>, '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 0x104053db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104225b20>, '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.0N1Y1L62Ke/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.noqIWM6oJS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 11:48:27 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 11:48:27 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 11:48:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0N1Y1L62Ke/Render', 11:48:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:48:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:48:27 INFO - 'HOME': '/Users/cltbld', 11:48:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:48:27 INFO - 'LOGNAME': 'cltbld', 11:48:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:27 INFO - 'MOZ_NO_REMOTE': '1', 11:48:27 INFO - 'NO_EM_RESTART': '1', 11:48:27 INFO - 'PAGER': '/bin/cat', 11:48:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:48:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:27 INFO - 'PWD': '/builds/slave/test', 11:48:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:48:27 INFO - 'SHELL': '/bin/bash', 11:48:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.noqIWM6oJS/Listeners', 11:48:27 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 11:48:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:48:27 INFO - 'USER': 'cltbld', 11:48:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:48:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:48:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:27 INFO - 'XPC_FLAGS': '0x0', 11:48:27 INFO - 'XPC_SERVICE_NAME': '0', 11:48:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:48:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:27 INFO - Downloading/unpacking flake8 11:48:27 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 11:48:27 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 11:48:27 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 11:48:27 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 11:48:27 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 11:48:27 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 11:48:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:48:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:48:30 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 11:48:30 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 11:48:30 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 11:48:30 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 11:48:30 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 11:48:30 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 11:48:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:48:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:48:30 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 11:48:30 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 11:48:30 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 11:48:30 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 11:48:30 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 11:48:30 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 11:48:31 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:48:31 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 11:48:31 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 11:48:31 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 11:48:31 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 11:48:31 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 11:48:31 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 11:48:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:48:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:48:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:48:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:48:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:48:31 INFO - no previously-included directories found matching 'docs/_build' 11:48:31 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:48:31 INFO - Running setup.py install for pep8 11:48:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:48:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:48:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:48:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:48:31 INFO - no previously-included directories found matching 'docs/_build' 11:48:31 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:48:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:48:31 INFO - Cleaning up... 11:48:31 INFO - Return code: 0 11:48:31 INFO - Running post-action listener: _resource_record_post_action 11:48:31 INFO - Running post-action listener: _start_resource_monitoring 11:48:31 INFO - Starting resource monitoring. 11:48:31 INFO - ##### 11:48:31 INFO - ##### Running install step. 11:48:31 INFO - ##### 11:48:31 INFO - Running pre-action listener: _resource_record_pre_action 11:48:31 INFO - Running main action method: install 11:48:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:48:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:48:32 INFO - Reading from file tmpfile_stdout 11:48:32 INFO - Detecting whether we're running mozinstall >=1.0... 11:48:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:48:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:48:32 INFO - Reading from file tmpfile_stdout 11:48:32 INFO - Output received: 11:48:32 INFO - Usage: mozinstall [options] installer 11:48:32 INFO - Options: 11:48:32 INFO - -h, --help show this help message and exit 11:48:32 INFO - -d DEST, --destination=DEST 11:48:32 INFO - Directory to install application into. [default: 11:48:32 INFO - "/builds/slave/test"] 11:48:32 INFO - --app=APP Application being installed. [default: firefox] 11:48:32 INFO - mkdir: /builds/slave/test/build/application 11:48:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:48:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 11:49:07 INFO - Reading from file tmpfile_stdout 11:49:07 INFO - Output received: 11:49:07 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:49:07 INFO - Running post-action listener: _resource_record_post_action 11:49:07 INFO - ##### 11:49:07 INFO - ##### Running run-tests step. 11:49:07 INFO - ##### 11:49:07 INFO - Running pre-action listener: _resource_record_pre_action 11:49:07 INFO - Running main action method: run_tests 11:49:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:49:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:49:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:49:07 INFO - 2016-03-18 11:49:07.065 screenresolution[6518:118932] starting screenresolution argv=screenresolution get 11:49:07 INFO - 2016-03-18 11:49:07.068 screenresolution[6518:118932] Display 0: 1600x1200x32@60 11:49:07 INFO - 2016-03-18 11:49:07.074 screenresolution[6519:118934] starting screenresolution argv=screenresolution list 11:49:07 INFO - Available Modes on Display 0 11:49:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:49:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:49:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:49:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:49:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:49:07 INFO - Intel Iris: 11:49:07 INFO - Chipset Model: Intel Iris 11:49:07 INFO - Type: GPU 11:49:07 INFO - Bus: Built-In 11:49:07 INFO - VRAM (Dynamic, Max): 1536 MB 11:49:07 INFO - Vendor: Intel (0x8086) 11:49:07 INFO - Device ID: 0x0a2e 11:49:07 INFO - Revision ID: 0x0009 11:49:07 INFO - Displays: 11:49:07 INFO - Display: 11:49:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:49:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:49:07 INFO - Display Serial Number: 1600x1200 60 11:49:07 INFO - Main Display: Yes 11:49:07 INFO - Mirror: Off 11:49:07 INFO - Online: Yes 11:49:07 INFO - Rotation: Supported 11:49:07 INFO - Return code: 0 11:49:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:49:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:49:07 INFO - Python 2.7.3 11:49:07 INFO - Return code: 0 11:49:07 INFO - grabbing minidump binary from tooltool 11:49: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')]} 11:49:07 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 0x10422ae00>, '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 0x104053db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104225b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:49:07 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 11:49:07 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 11:49:07 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:49:07 INFO - Return code: 0 11:49:07 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:49:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:49:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:49:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:49:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:49:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:49:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:49:08 INFO - Return code: 0 11:49:08 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/XTG0GOXhSASlgG41JAt3Ag/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0102', '--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 11:49:08 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/XTG0GOXhSASlgG41JAt3Ag/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0102 --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 11:49:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0N1Y1L62Ke/Render', 11:49:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:49:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:49:08 INFO - 'HOME': '/Users/cltbld', 11:49:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:49:08 INFO - 'LOGNAME': 'cltbld', 11:49:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:49:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:49:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:08 INFO - 'MOZ_NO_REMOTE': '1', 11:49:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:49:08 INFO - 'NO_EM_RESTART': '1', 11:49:08 INFO - 'PAGER': '/bin/cat', 11:49:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:49:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:08 INFO - 'PWD': '/builds/slave/test', 11:49:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:49:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:49:08 INFO - 'SHELL': '/bin/bash', 11:49:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.noqIWM6oJS/Listeners', 11:49:08 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 11:49:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:49:08 INFO - 'USER': 'cltbld', 11:49:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:49:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:49:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:08 INFO - 'XPC_FLAGS': '0x0', 11:49:08 INFO - 'XPC_SERVICE_NAME': '0', 11:49:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:49:08 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/XTG0GOXhSASlgG41JAt3Ag/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0102', '--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 11:49:08 INFO - mozversion application_buildid: 20160318092810 11:49:08 INFO - mozversion application_changeset: dbba8191f3c1e22505f5e5d5b8537f719eafb51d 11:49:08 INFO - mozversion application_display_name: Nightly 11:49:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:49:08 INFO - mozversion application_name: Firefox 11:49:08 INFO - mozversion application_remotingname: firefox 11:49:08 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:49:08 INFO - mozversion application_vendor: Mozilla 11:49:08 INFO - mozversion application_version: 48.0a1 11:49:08 INFO - mozversion platform_buildid: 20160318092810 11:49:08 INFO - mozversion platform_changeset: dbba8191f3c1e22505f5e5d5b8537f719eafb51d 11:49:08 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:49:08 INFO - mozversion platform_version: 48.0a1 11:49:08 INFO - using testdate: 1458326948 11:49:08 INFO - actual date: 1458326948 11:49:08 INFO - starting webserver on 'localhost:59372' 11:49:08 INFO - SUITE-START | Running 2 tests 11:49:08 INFO - TEST-START | dromaeo_css 11:49:08 INFO - operating with platform_type : mac_ 11:49:08 INFO - Initialising browser for dromaeo_css test... 11:49:08 INFO - TEST-INFO | started process 6537 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmpkI0GnD/profile http://localhost:59372/getInfo.html) 11:49:11 INFO - PROCESS | 6537 | __metrics Screen width/height:1600/1200 11:49:11 INFO - PROCESS | 6537 | colorDepth:24 11:49:11 INFO - PROCESS | 6537 | Browser inner width/height: 1024/689 11:49:11 INFO - PROCESS | 6537 | __metrics 11:49:11 INFO - PROCESS | 6537 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:49:11 ERROR - PROCESS | 6537 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:49:11 INFO - TEST-INFO | 6537: exit 0 11:49:11 INFO - Browser initialized. 11:49:11 INFO - Running cycle 1/1 for dromaeo_css test... 11:49:11 INFO - TEST-INFO | started process 6540 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmpkI0GnD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:49:23 INFO - PROCESS | 6540 | RSS: Main: 243474432 11:49:23 INFO - PROCESS | 6540 | 11:50:15 INFO - PROCESS | 6540 | 1458327015330 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] 11:52:25 INFO - PROCESS | 6540 | Cycle 1(1): loaded http://localhost:59372/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59372/tests/dromaeo/cssquery-ext.html) 11:52:26 INFO - PROCESS | 6540 | RSS: Main: 333680640 11:52:26 INFO - PROCESS | 6540 | 11:55:29 INFO - PROCESS | 6540 | Cycle 1(1): loaded http://localhost:59372/tests/dromaeo/cssquery-ext.html (next: http://localhost:59372/tests/dromaeo/cssquery-jquery.html) 11:55:30 INFO - PROCESS | 6540 | RSS: Main: 379609088 11:55:30 INFO - PROCESS | 6540 | 11:58:32 INFO - PROCESS | 6540 | Cycle 1(1): loaded http://localhost:59372/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59372/tests/dromaeo/cssquery-mootools.html) 11:58:32 INFO - PROCESS | 6540 | RSS: Main: 378368000 11:58:32 INFO - PROCESS | 6540 | 12:01:34 INFO - PROCESS | 6540 | Cycle 1(1): loaded http://localhost:59372/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59372/tests/dromaeo/cssquery-prototype.html) 12:01:35 INFO - PROCESS | 6540 | RSS: Main: 338247680 12:01:35 INFO - PROCESS | 6540 | 12:04:38 INFO - PROCESS | 6540 | Cycle 1(1): loaded http://localhost:59372/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59372/tests/dromaeo/cssquery-yui.html) 12:04:39 INFO - PROCESS | 6540 | RSS: Main: 340328448 12:04:39 INFO - PROCESS | 6540 | 12:07:42 INFO - PROCESS | 6540 | Cycle 1(1): loaded http://localhost:59372/tests/dromaeo/cssquery-yui.html (next: http://localhost:59372/tests/dromaeo/cssquery-dojo.html) 12:07:42 INFO - PROCESS | 6540 | RSS: Main: 431079424 12:07:42 INFO - PROCESS | 6540 | 12:07:42 INFO - PROCESS | 6540 | __start_tp_report 12:07:42 INFO - PROCESS | 6540 | _x_x_mozilla_page_load 12:07:42 INFO - PROCESS | 6540 | _x_x_mozilla_page_load_details 12:07:42 INFO - PROCESS | 6540 | |i|pagename|runs| 12:07:42 INFO - PROCESS | 6540 | |0;dojo.html;3381.8985430437087;3423.7261019118473;3461.8269086545665;3465.6187819339884;3504.7371447141472;4888.486708895563;5328.520433161015;5621.269234999444;5678.176664383662;5688.3458402283695;5587.161925711145;5644.153376993453;5652.0391533439315;5666.348369937458;5682.0056490114275;5126.307948426952;5152.536271735543;5167.405748338932;5195.454477279888;5242.292290540767;5236.685798852062;5259.86850328741;5260.0268950244135;5263.0263401270695;5274.314339135907;5092;5128.794848206067;5154.536091751742;5167.48325167484;5245.4754524547625;5199.402068762084;5211.791528338862;5236.764345604457;5240.344956880409;5292.126799078147;3811.7141214408753;5100.438951715309;5110.744462776884;5157.097507936133;5211.400688920785;5554.166874968747;5563.221149039137;5598;5603.131514615241;5668.149777533362;5443.863903402446;6197.349278325756;6212.099245609361;6225.906611400833;6246;6120.203342909613;6124;6206.6586337751405;6224.439800417938;6237.220347456568;5808.5933984621515;5814.156947242626;5840.561957853178;5842.269716285465;5843.620164689281;6189.102580125947;6248.750049997949;6260.874782504325;6270.843228919313;6275.058741188767;6012.188354572077;6026.035834266497;6092.421219984094;6132.324915438597;6159.4456498915315;6170.660613666291;6220.657863817443;6232.688365581703;6253.062040693932;6257.217847769029;6204.348543402968;6207.96896015517;6210.130581718563;6223.315435302113;6223.439890409885;5714.542836573064;6107.114468402146;6169.598976066542;6196.349383314777;6234.064890266496;4884.755762211947;4888.193448081098;4894.0730771148565;4898.461169271377;4912.484189160158;4411.933820992687;4415.977920110379;4438.245498265238;4448.266036104072;4472.664550158751;5639.492445679908;5683.630564013326;5701.828945131652;5793.797217097382;5811.070228763378;6162.127139973639;6197.876042479125;6222.191115155001;6228.252609686867;6231.158793562811;5759.942400576025;5763.567732420001;5784.595078344475;5787.074068149076;5790.073588225948;5266.1574148136115;5330.333708286465;5391.514763671288;5397.865053373697;5457.317835270591;6327.367263273728;6344.714487848058;6353.777617783356;6366.840828979312;6380.680965951591;6133.487685122479;6221.844453888689;6228;6228.968855155696;6231.9688401557705;6220.844478887883;6254.499640028877;6271.592346497463;6293.056041593798;6307.306196318493;5208.3229180207845;6105;6140.263168419819;6149.661768602591;6179.474744646575;6098.43222861686;6146.754129834757;6245.594036387621;6245.812625621239;6267.467265282502;5497.092979658311;6023.6385816851125;6122.142899994094;6168.290646575701;6190.2571691397325;5899.439553242435;6149.538784591263;6154.353792851686;6155.0151975683675;6159.907601385893;5886.882262354815;5992.730327135202;6036.215292012011;6038.818835434944;6081.422264884829;6004.759809607567;6040.788572399945;6077.604955677867;6120.699964124781;6149.84625384369;5976.043832986701;6001.549883758823;6005.189299444519;6016.909746353721;6024.638521688713 12:07:42 INFO - PROCESS | 6540 | |1;ext.html;450.2952878744766;537.0789096699162;571.8677019501386;579.3887448741576;634.3402861024534;36831.631683683154;38724.80637596808;38848.805755971254;38860;38904;40704.98237544063;41017;41179.38230926531;41185.7940710296;41233;9416.199623032051;9616.711498655051;9640.42157470554;9655.5172241388;9665.710028699115;9519;9714.902850971506;9717.56270967808;9720.805583888317;9727.367721098106;9695.127438530531;9767.218622510218;9774.266929980244;9778.217742580577;9788.951055244714;9632.903670963306;9705;9721.416714997053;9737.123658870736;9742.902570974271;9592.760180995461;9731.270154738422;9744.31789774716;9744.853827192597;9751.36616119957;33265.334693305995;39875.20249595021;40297.79851100755;40345.59654403477;40367.99080023023;2369.6919400478;3186.85659145339;3204.2630195055035;3206.9518957215428;3333.833308334598;27933;28153.43693126126;28251.293717657016;28377.85811070952;28973.42053158925;2735.8084934054623;2739.068716636353;2755.1596762987283;2850.586664933573;2902.985485072561;413436.93281533703;416791;417904.999999997;419241.8075819233;421079;60430.39569604336;67423.66288168626;67747;68256.6587167061;68374;62818;63965.68017159885;74281.20047395054;75075.24924750683;75109;17193.828061719472;17198.054107023985;17323.740143897852;17349.2192851322;17355.21901514435;11876.287422754662;12933.353332333345;12994.935025324812;13027.804582931263;13033.543825966235;21478.637349891498;21980.560388792135;22006.779932200792;22023.33929982071;22064.117435302407;9127.954360228288;9415.15263626277;9419.481928493999;9430.62277508892;9447.001154267089;997.0627610046533;1000.7240768020831;1038.9688309350731;1083.9702282831342;1148.7530181010954;24892.626610600855;29486.557701634065;29969.100926972227;30193.547096793565;30386.54420183699;1010.4796030044386;1046.6546039806844;1084.1218612923558;1203.464458316041;1237.2638280223252;14727.337269822883;14746.852531474762;14852.683976859924;14880.776788348183;15051.322690478955;432816;437457;442128;443566;444248;57848.42151578514;58242.7087864558;58267.70866145642;58285.417145827996;58567.70716146392;1345.5559665310425;1460.8247010358612;1467.3250304859885;1504.9021813582083;1517.6205948512873;27240.455190895675;28559.571606426336;28800;29283;29454.705452945196;47015.05969880515;47250;47374.526254737015;47523.524764751906;47530;272679;276537;276555;276748;276900;28981.42037159287;33216.50175247325;34447.65552344545;34502.30995380128;34532.82733586417;41296.587034129276;42099.158016840105;42477.57522424736;42551.148977019664;42949;27529.31176720598;35417.64582354143;36153.096172594844;36164.27671446609;36481.63518364782;34612.82693586516;34998.650013500555;35825.283494329444;35926.820365898006;36346.8182659085;35706.821465892506;36764.63235367719;36815.63184368122;37050.25899482049;37367.6263237375;31863.03827751159;31940.041798746075;32230.35539289248;32320.676793231767;32718.34563308768;24239.03043878225;24258.393540161636;24411.51176976486;24494.63258051095;24663.63004554969 12:07:42 INFO - PROCESS | 6540 | |2;jquery.html;355.67455777963164;360.6321552016943;361.19273423897585;369.59160128058494;370.3944051475836;19513.512162195933;20143.59712805745;21017.159313627435;21534.89232553839;21536;18746.531336716587;18925.432237032877;19349.516262093453;19545.51136221595;19570.06449032646;5209.244659524366;5334.893302133974;5342.252084708144;5376.166694162411;5382.730863456831;3861.131245469761;4040.939385909214;5287.735613219343;5623.606347555673;5913.9112913306335;5866.090755932816;5895.646261224319;5898;5904.527637788967;5905.970470147643;5625.128105143709;5711.942880571203;5810.796622118248;5819.0689489681445;5894.469497745202;5544.085225937715;5549.445055494418;5556.583256255797;5563.860903477445;5580.581456390787;15547.378104875792;23423.297301080995;24002.879985600135;24221.273361799173;24294.635580466307;1983.633027889845;2022.0395312226574;2097.5595125023765;2161.6001039807684;2173.119886445992;9255.768605784842;9850.901490985141;10086.394816311045;10103.19174466041;10153.194669323702;1634.411611819744;1709.623882745794;1744.0930716027722;1759.9648007039916;1809.2039502618807;89843;92052.53973730156;92506.53746731291;92683.60974585454;92784.53607731986;10952.4523773811;11134.443277836075;11167.441627918734;11195.384253866116;11327.603533876274;13442.193468391928;13535.120217185851;13535.864641353657;13565.728685426237;13574;8406.075331713506;8497.150284971452;8533.530655813865;8620;8675.04811417426;8566.61450234741;8574;8614.05245423003;8730.38887277897;8737.956310218535;3907.3552863777727;4184.895377615584;4458.464984201852;4466.2630665940405;4486.282194848874;1725.5254804928745;1787.6335351252962;1851.7037274036359;1870.2238570992886;1884.406411980222;917.206616276929;931.7111695374456;946.7491114854569;998.8413440409236;1028.5217373921162;17932.91033544824;18429.447116586525;18739.531511712317;18748.25006999732;18924.24303027891;930.2325581395376;967.6468089147411;987.7530617345664;989.2877128467636;1012.372329155928;10152.340097893613;10184.185265178769;10221.43782091992;10227.846582301272;10241.539130739135;584740;594521;596399;603204;605584;98899.47396553958;102697;103779;105833.47083264688;107287;1022.2128960700368;1034.7464871106627;1045.1168762395764;1046.4244665434132;1052.5211028981641;14133.505327313494;16998.175410533026;17296.308147673953;17359.739603906204;17455.304945686166;45722.08555828931;46397.536024639325;46860.7656961713;47596.7620161897;48039.75980120077;47295;62094.44763880939;65831;67351.65296694137;69002.65498672475;7613.961930190314;7669.463137580316;7825.765227043198;7852.528848269122;7854.2145785421;10617.362958222531;12015.879841201477;12127.81808272859;12165.219258600842;12297.200681955645;10499.94750026245;10560.155187584822;10693.037626613332;10741.570337186426;10886.945565272123;9465.290103242147;9782.266330025419;10346.793064138825;10447.320924139907;10619.1504679627;10639.521221545205;10730.839037414602;10935.507902144582;10971;11032.22774405816;6475.708593113227;7597.582132982739;7664.233576642291;7771.766846994599;7991.600419979094;10066.94966525192;10562.841557376492;10782.406967616856;10839.078678312431;10841 12:07:42 INFO - PROCESS | 6540 | |3;mootools.html;1454.905431146976;1590.4194968836375;1615.741481362982;1887.5469887227061;2027.6147531968925;7971.720989765359;8620.482771033743;8809.163129502704;8809.163129502704;8816.382853200279;8376.916230837689;8623.094575069621;8623.439476434027;8635.13648635136;8636.524991125485;2168.793964573363;2399.700037495313;2457.152282462552;2465.2604218734396;2486.5648511510412;2439.7682220189054;2440.670509481224;2441.5971364724887;2444.5721998650165;2449.2529778417575;2418.6855708757835;2453.1904471524354;2483.1004281724495;2483.8261321707487;2484.6397272395493;2448.7061552613714;2461.4092617771785;2469.604863221885;2481.727010028895;2487.763662452064;2420.261820144855;2444.792192663608;2445.0708730682404;2447.865367404792;2459.090136649433;8690.782730431727;8784.253338466238;8803.911960880374;8805.867911981326;8821.911780882174;5417.729113544347;5558.082916318803;5568.52667523261;5569.805056822992;5583.720813959327;3552.2007548301685;3672.7796332219887;3709.1098136447326;3726.9068273293383;3733.4213196954242;1018.5365658625308;1031.9535620897077;1039.5893622019335;1047.7171163785736;1047.9423631700254;11903.94048029763;11913.225640333438;11913.404329783476;11913.583024594098;11920.582779602759;4228;4831.178699621002;4886.462489126193;4890.510948905152;4951.430585482643;9954.651587194414;10004.899951000396;10027.498625068718;10045.79908401828;10048.447335396624;5548.69482178476;5549.139883318092;5551.056320425538;5552.833414997556;5558;4473.575010374009;4595.471520775087;4880.292357608198;4933.333999909966;4994.825181118644;3846.4230365444846;3935.370340745467;3943.7042221833476;3956.1999290322833;3967.78177200251;1284.563248495516;1298.7077907470743;1303.328785675378;1317.631063302277;1320.821689071963;1320.9867901320863;1352.48605529898;1359.9932000340134;1370.9657258568616;1373.684052667892;8180.14108518597;8185.3451723861945;8206.712765053195;8226.177382261725;8237.958810205912;460.99078018439445;486.6544753225179;490.7374554613265;491.2851800630146;494.1352632892438;5947.37552556984;6143.508519318444;6194.628322300587;6218.626882387071;6222.3466536013975;10422.583096676048;10713.517891694892;10729.409882456539;10852.131829453625;10871.239013268996;10414.947925260325;10616.097631701237;10687.091597214323;10712.35725856451;10734.892651073389;8138.918610813935;8189.344852411674;8267.379946504036;8271.33829293655;8359.874601880976;7806.258405451473;7849.8037549059445;7852.568108754073;7877.291043806085;7906.52560846351;9466.810663786824;9596.568154432927;9611.759706007406;9663.27525435581;9729.173020293354;9856.31005829585;9895.455749933823;9902;9925.553350099119;10046.69859904204;6675.332466753286;6888.138982627172;7324.670389832364;7399.741009064657;7485.1766305707415;8112.351011918914;8136.06435259929;8158.755237342889;8176.386770992318;8188;7215.783526494213;7259.782206533812;7289.744858929912;7404.703811847681;7441.702331906879;7169.856602868018;7222.313880181375;7248.710051597877;7260.709571617076;7306.2693730626515;7623.771286861182;7714.11287701899;7715.884261735966;7724.343430808444;7734.1105772836845;6951.7914462566205;6973.372396484341;7056.54132481387;7065.187503437171;7065.505414620927;7113.82215444618;7169.354758071799;7171.820704482429;7177.820554486179;7186.7125314986815 12:07:42 INFO - PROCESS | 6540 | |4;prototype.html;321.60763868080943;324.9350129974004;328.70252421558496;330.3904296572823;334.83927714696944;5461.743798926249;6540.084388185652;6545.869082618345;6603.603783772971;6652;6485.254195767488;6520.152380190569;6525.771597994071;6533.444657204143;6533.607983520992;4318.827246910136;4336.4362632857765;4704.153252414564;4724.834630787923;4763.118823017753;4120.423140760281;4701.788419521113;4829.975850120744;4849.636277279201;4876.4148302203785;4782.13921494131;4793.784279707422;4799.520047995207;4823.34884790554;4830.299606557047;4564.338170965208;4622;4755.952440475586;4798.136335459616;4822.107910036654;4100.938485922714;4118.094019315746;4119.990602302425;4132.876013719593;4150.605692459211;5680.971595142039;6228.844278893019;6282.089097080943;6310.873782524323;6320.74717011319;5611.410801865786;5612.550995920357;5614.747336369873;5626.9437305626825;5633.408492108351;6919.792406227822;6920.446364290895;6929.376356127922;6930.20302665195;6932.826679333007;4488.124815660947;4608.723476591415;4658.58072773452;4660.997885454643;4716.740579268139;6974.755883544051;7032.542884712478;7073.469489788286;7077.398421134261;7080.433565314763;4691.9530804692195;4696.412948381452;4704.458987216445;4708.270218116198;4720.150372932905;4395.494518130456;4769.974455492016;4773.734960235541;4795.712257264575;4863.468007577601;5561.527270181999;5565.860853478695;5581.804636837691;5584.720763961785;5599.720013999284;6607.482751902119;6744.595324280559;6838.281980392087;6848.657567121624;6877.3810357067105;1472.786445965329;1665.392131871858;1695.1947824783128;1695.4998275508754;1698.9235484402984;1084.159776173456;1087.2986923434341;1103.1395511501041;1117.3910218930703;1121.8317252412203;6355.586886852339;6488.383603557654;6554.573952693059;6618.602883826986;6655.73377064912;5922.851928701731;6746.460283177334;7311.0495635568095;7312.670929808171;7317.6217729238215;5452.509274165265;6597.505187110986;6608.636524991171;6641;6643.202815662152;3802.6767724743154;3848.8460461581785;3851.0372406898277;3851.537815462106;3851.7496362736333;7220.566765994057;7379.852402951911;7493.4005279577505;7500.624968751541;7560.470767046254;7463.029806125169;7495.362894153949;7506.662200201004;7513.661885215069;7522.811929701801;6178.567500274938;7559.470837041355;7571.9777829993345;7580.279873412017;7597.126330471956;7257.383122434652;7258.637068146677;7259.963700181465;7264.200937896932;7292.380147687506;5511.779528818803;7056.223815380202;7056.259092795182;7062.540934839219;7075.893861592183;7515.736949206752;7565.962170189114;7575.318221360104;7590.620468976419;7596.506227095221;4531.365608814835;4562.908741825211;4568.2005649010625;4568.383268258743;4570.200214962435;5880.353161152184;7184.784456466315;7192.928070719226;7196.452762656054;7206.7117315306805;6663.866722665616;6956.165260168812;6982.092327997328;6990.370866622028;7011.053507776385;6954.408875245661;6985.545939513915;6989.26612705679;6992.1259842519685;7007.929920700728;6817.93182068173;6843.828904277234;6845.452363810983;6852.417544508772;6856.24581296047;6708.127943367331;6958.652067396712;6963.268856770169;6966.442684585322;6970.79087627372;5687.829365119053;6516.5112616553;6647.401733843977;6679.833004174934;6715.563488373436 12:07:42 INFO - PROCESS | 6540 | |5;yui.html;682.856600113976;727.7962170592236;744.4788647946439;745.2584678245145;760.2017881224713;12441.55638323163;14485;14795.926020369896;15096.245187740624;15111.168885711282;13963.790543141835;14049.719005619882;14111.576652700409;14123.858761412383;14132;703.8240439890028;855.102142750113;873.7815546113471;875.6366108065178;875.763543843162;721;861.7673228228375;884.0364003236471;886.2112719679491;887.0685779931079;932.0912110692088;932.235566835192;932.7807965128223;934.8364036293656;936.0312077000306;749.7375918428561;917.7751450894574;925.726910561386;927.5501381829807;929.7907970706605;699.4020112803581;703.8345988692653;705.3193668110247;705.8447141628833;706.1808302369227;14714.558563243012;14760.63098422548;14786.260686965608;14805.037672551358;14818.96267261292;12291.201071930296;12407.75184496314;12425.813612795815;12488.937555312255;12679.302638354888;8297.668093276323;9932.006799320083;10053.849192262122;10103.343282686676;10304.278700490968;3452.781074531008;3479.7216222702377;3498.230389314372;3532.4701294805727;3585.9641403585892;76816.99999999945;76980;77039.61480192619;77264.61367693126;77371;9391.953040234755;9476.810463790824;9495.14543691071;9751.561179746928;9753.073458021476;20922.581548368948;21141;21204.04581793823;22624.321270361914;22625.2081177158;7496.850062998818;7512.13610434807;7629.0845098588525;7771.494852834548;7869.331106855867;4059.9594004060173;4114.814833332507;4155.4182414462;4165.937510937339;4232.682548808852;3637.5089362935664;3695.3163664721574;3698.6116457772087;3704.388775852008;3707.8146092695256;689.975850845218;699.4055053204735;712.2877122877123;719.0939416335455;724.6123324021623;425.47241420638187;430.4382780471452;514.477805027897;542.0487045235586;552.7733629212004;7763.60266056048;7935;7966;8007.599620018976;8275.296599789086;578.9015867302569;581.4824805922732;596.5049009322252;601.2424345324922;604.7732100462326;3700.4449332600325;3790.9241815164096;3835.8082095895093;3845.2309538091936;3849.6920246380223;92585;94875.52562237282;95299;95303;95370.5231473852;79074.60462697649;79415.20584794194;81596;81887;82186.58906705548;73207.63396183091;73363.89954150692;73450.63274683592;73868;74607;6256.289668503486;7545.50954187976;7645.732399366218;7651.579163146081;7802;49297.753511232215;51454.56817897763;51544.48455515397;51640;51825;69904.6504767473;70129.89610311699;70411.64794175996;70565;71483;9914.900850991398;10043.296969212377;10045.849312260469;10214.693559193236;10476.161907047266;10765.013457510746;10914.345139291669;10946.671599852018;11177;11428.885711142782;10157.79684406293;10276.280660353703;10322.948385258025;10530.05229529346;10591.258611897401;10301.793964120825;10564.630237941636;10646.095081917814;10742.677719668422;10797.352158870493;9963.551640176354;10000.349977251455;10096.242781791248;10138.847917281098;10258.846117308396;7341.155767086853;8055.919440805751;8526.658933642833;8528.658853645784;8655.6970506032;8041.597920103854;8051;8669.60986755585;8705.260052895575;8789.91210087891 12:07:42 INFO - PROCESS | 6540 | __end_tp_report 12:07:42 INFO - PROCESS | 6540 | __start_cc_report 12:07:42 INFO - PROCESS | 6540 | _x_x_mozilla_cycle_collect,1154 12:07:42 INFO - PROCESS | 6540 | __end_cc_report 12:07:42 INFO - PROCESS | 6540 | __startTimestamp1458328062293__endTimestamp 12:07:42 INFO - PROCESS | 6540 | 12:07:42 INFO - PROCESS | 6540 | ------- Summary: start ------- 12:07:42 INFO - PROCESS | 6540 | Number of tests: 6 12:07:42 INFO - PROCESS | 6540 | 12:07:42 INFO - PROCESS | 6540 | [#0] dojo.html Cycles:165 Average:5708.29 Median:5992.73 stddev:644.55 (10.8%) stddev-sans-first:620.15 12:07:42 INFO - PROCESS | 6540 | Values: 3381.9 3423.7 3461.8 3465.6 3504.7 4888.5 5328.5 5621.3 5678.2 5688.3 5587.2 5644.2 5652.0 5666.3 5682.0 5126.3 5152.5 5167.4 5195.5 5242.3 5236.7 5259.9 5260.0 5263.0 5274.3 5092.0 5128.8 5154.5 5167.5 5245.5 5199.4 5211.8 5236.8 5240.3 5292.1 3811.7 5100.4 5110.7 5157.1 5211.4 5554.2 5563.2 5598.0 5603.1 5668.1 5443.9 6197.3 6212.1 6225.9 6246.0 6120.2 6124.0 6206.7 6224.4 6237.2 5808.6 5814.2 5840.6 5842.3 5843.6 6189.1 6248.8 6260.9 6270.8 6275.1 6012.2 6026.0 6092.4 6132.3 6159.4 6170.7 6220.7 6232.7 6253.1 6257.2 6204.3 6208.0 6210.1 6223.3 6223.4 5714.5 6107.1 6169.6 6196.3 6234.1 4884.8 4888.2 4894.1 4898.5 4912.5 4411.9 4416.0 4438.2 4448.3 4472.7 5639.5 5683.6 5701.8 5793.8 5811.1 6162.1 6197.9 6222.2 6228.3 6231.2 5759.9 5763.6 5784.6 5787.1 5790.1 5266.2 5330.3 5391.5 5397.9 5457.3 6327.4 6344.7 6353.8 6366.8 6380.7 6133.5 6221.8 6228.0 6229.0 6232.0 6220.8 6254.5 6271.6 6293.1 6307.3 5208.3 6105.0 6140.3 6149.7 6179.5 6098.4 6146.8 6245.6 6245.8 6267.5 5497.1 6023.6 6122.1 6168.3 6190.3 5899.4 6149.5 6154.4 6155.0 6159.9 5886.9 5992.7 6036.2 6038.8 6081.4 6004.8 6040.8 6077.6 6120.7 6149.8 5976.0 6001.5 6005.2 6016.9 6024.6 12:07:42 INFO - PROCESS | 6540 | 12:07:42 INFO - PROCESS | 6540 | [#1] ext.html Cycles:180 Average:54265.95 Median:36623.13 stddev:101727.56 (277.8%) stddev-sans-first:101932.69 12:07:42 INFO - PROCESS | 6540 | Values: 450.3 537.1 571.9 579.4 634.3 36831.6 38724.8 38848.8 38860.0 38904.0 40705.0 41017.0 41179.4 41185.8 41233.0 9416.2 9616.7 9640.4 9655.5 9665.7 9519.0 9714.9 9717.6 9720.8 9727.4 9695.1 9767.2 9774.3 9778.2 9789.0 9632.9 9705.0 9721.4 9737.1 9742.9 9592.8 9731.3 9744.3 9744.9 9751.4 33265.3 39875.2 40297.8 40345.6 40368.0 2369.7 3186.9 3204.3 3207.0 3333.8 27933.0 28153.4 28251.3 28377.9 28973.4 2735.8 2739.1 2755.2 2850.6 2903.0 413436.9 416791.0 417905.0 419241.8 421079.0 60430.4 67423.7 67747.0 68256.7 68374.0 62818.0 63965.7 74281.2 75075.2 75109.0 17193.8 17198.1 17323.7 17349.2 17355.2 11876.3 12933.4 12994.9 13027.8 13033.5 21478.6 21980.6 22006.8 22023.3 22064.1 9128.0 9415.2 9419.5 9430.6 9447.0 997.1 1000.7 1039.0 1084.0 1148.8 24892.6 29486.6 29969.1 30193.5 30386.5 1010.5 1046.7 1084.1 1203.5 1237.3 14727.3 14746.9 14852.7 14880.8 15051.3 432816.0 437457.0 442128.0 443566.0 444248.0 57848.4 58242.7 58267.7 58285.4 58567.7 1345.6 1460.8 1467.3 1504.9 1517.6 27240.5 28559.6 28800.0 29283.0 29454.7 47015.1 47250.0 47374.5 47523.5 47530.0 272679.0 276537.0 276555.0 276748.0 276900.0 28981.4 33216.5 34447.7 34502.3 34532.8 41296.6 42099.2 42477.6 42551.1 42949.0 27529.3 35417.6 36153.1 36164.3 36481.6 34612.8 34998.7 35825.3 35926.8 36346.8 35706.8 36764.6 36815.6 37050.3 37367.6 31863.0 31940.0 32230.4 32320.7 32718.3 24239.0 24258.4 24411.5 24494.6 24663.6 12:07:42 INFO - PROCESS | 6540 | 12:07:42 INFO - PROCESS | 6540 | [#2] jquery.html Cycles:180 Average:32539.93 Median:24257.95 stddev:98460.54 (405.9%) stddev-sans-first:98707.09 12:07:42 INFO - PROCESS | 6540 | Values: 355.7 360.6 361.2 369.6 370.4 19513.5 20143.6 21017.2 21534.9 21536.0 18746.5 18925.4 19349.5 19545.5 19570.1 5209.2 5334.9 5342.3 5376.2 5382.7 3861.1 4040.9 5287.7 5623.6 5913.9 5866.1 5895.6 5898.0 5904.5 5906.0 5625.1 5711.9 5810.8 5819.1 5894.5 5544.1 5549.4 5556.6 5563.9 5580.6 15547.4 23423.3 24002.9 24221.3 24294.6 1983.6 2022.0 2097.6 2161.6 2173.1 9255.8 9850.9 10086.4 10103.2 10153.2 1634.4 1709.6 1744.1 1760.0 1809.2 89843.0 92052.5 92506.5 92683.6 92784.5 10952.5 11134.4 11167.4 11195.4 11327.6 13442.2 13535.1 13535.9 13565.7 13574.0 8406.1 8497.2 8533.5 8620.0 8675.0 8566.6 8574.0 8614.1 8730.4 8738.0 3907.4 4184.9 4458.5 4466.3 4486.3 1725.5 1787.6 1851.7 1870.2 1884.4 917.2 931.7 946.7 998.8 1028.5 17932.9 18429.4 18739.5 18748.3 18924.2 930.2 967.6 987.8 989.3 1012.4 10152.3 10184.2 10221.4 10227.8 10241.5 584740.0 594521.0 596399.0 603204.0 605584.0 98899.5 102697.0 103779.0 105833.5 107287.0 1022.2 1034.7 1045.1 1046.4 1052.5 14133.5 16998.2 17296.3 17359.7 17455.3 45722.1 46397.5 46860.8 47596.8 48039.8 47295.0 62094.4 65831.0 67351.7 69002.7 7614.0 7669.5 7825.8 7852.5 7854.2 10617.4 12015.9 12127.8 12165.2 12297.2 10499.9 10560.2 10693.0 10741.6 10886.9 9465.3 9782.3 10346.8 10447.3 10619.2 10639.5 10730.8 10935.5 10971.0 11032.2 6475.7 7597.6 7664.2 7771.8 7991.6 10066.9 10562.8 10782.4 10839.1 10841.0 12:07:42 INFO - PROCESS | 6540 | 12:07:42 INFO - PROCESS | 6540 | [#3] mootools.html Cycles:180 Average:6037.51 Median:5483.21 stddev:3198.49 (58.3%) stddev-sans-first:3188.91 12:07:42 INFO - PROCESS | 6540 | Values: 1454.9 1590.4 1615.7 1887.5 2027.6 7971.7 8620.5 8809.2 8809.2 8816.4 8376.9 8623.1 8623.4 8635.1 8636.5 2168.8 2399.7 2457.2 2465.3 2486.6 2439.8 2440.7 2441.6 2444.6 2449.3 2418.7 2453.2 2483.1 2483.8 2484.6 2448.7 2461.4 2469.6 2481.7 2487.8 2420.3 2444.8 2445.1 2447.9 2459.1 8690.8 8784.3 8803.9 8805.9 8821.9 5417.7 5558.1 5568.5 5569.8 5583.7 3552.2 3672.8 3709.1 3726.9 3733.4 1018.5 1032.0 1039.6 1047.7 1047.9 11903.9 11913.2 11913.4 11913.6 11920.6 4228.0 4831.2 4886.5 4890.5 4951.4 9954.7 10004.9 10027.5 10045.8 10048.4 5548.7 5549.1 5551.1 5552.8 5558.0 4473.6 4595.5 4880.3 4933.3 4994.8 3846.4 3935.4 3943.7 3956.2 3967.8 1284.6 1298.7 1303.3 1317.6 1320.8 1321.0 1352.5 1360.0 1371.0 1373.7 8180.1 8185.3 8206.7 8226.2 8238.0 461.0 486.7 490.7 491.3 494.1 5947.4 6143.5 6194.6 6218.6 6222.3 10422.6 10713.5 10729.4 10852.1 10871.2 10414.9 10616.1 10687.1 10712.4 10734.9 8138.9 8189.3 8267.4 8271.3 8359.9 7806.3 7849.8 7852.6 7877.3 7906.5 9466.8 9596.6 9611.8 9663.3 9729.2 9856.3 9895.5 9902.0 9925.6 10046.7 6675.3 6888.1 7324.7 7399.7 7485.2 8112.4 8136.1 8158.8 8176.4 8188.0 7215.8 7259.8 7289.7 7404.7 7441.7 7169.9 7222.3 7248.7 7260.7 7306.3 7623.8 7714.1 7715.9 7724.3 7734.1 6951.8 6973.4 7056.5 7065.2 7065.5 7113.8 7169.4 7171.8 7177.8 7186.7 12:07:42 INFO - PROCESS | 6540 | 12:07:42 INFO - PROCESS | 6540 | [#4] prototype.html Cycles:180 Average:5670.12 Median:6518.33 stddev:1794.91 (27.5%) stddev-sans-first:1754.48 12:07:42 INFO - PROCESS | 6540 | Values: 321.6 324.9 328.7 330.4 334.8 5461.7 6540.1 6545.9 6603.6 6652.0 6485.3 6520.2 6525.8 6533.4 6533.6 4318.8 4336.4 4704.2 4724.8 4763.1 4120.4 4701.8 4830.0 4849.6 4876.4 4782.1 4793.8 4799.5 4823.3 4830.3 4564.3 4622.0 4756.0 4798.1 4822.1 4100.9 4118.1 4120.0 4132.9 4150.6 5681.0 6228.8 6282.1 6310.9 6320.7 5611.4 5612.6 5614.7 5626.9 5633.4 6919.8 6920.4 6929.4 6930.2 6932.8 4488.1 4608.7 4658.6 4661.0 4716.7 6974.8 7032.5 7073.5 7077.4 7080.4 4692.0 4696.4 4704.5 4708.3 4720.2 4395.5 4770.0 4773.7 4795.7 4863.5 5561.5 5565.9 5581.8 5584.7 5599.7 6607.5 6744.6 6838.3 6848.7 6877.4 1472.8 1665.4 1695.2 1695.5 1698.9 1084.2 1087.3 1103.1 1117.4 1121.8 6355.6 6488.4 6554.6 6618.6 6655.7 5922.9 6746.5 7311.0 7312.7 7317.6 5452.5 6597.5 6608.6 6641.0 6643.2 3802.7 3848.8 3851.0 3851.5 3851.7 7220.6 7379.9 7493.4 7500.6 7560.5 7463.0 7495.4 7506.7 7513.7 7522.8 6178.6 7559.5 7572.0 7580.3 7597.1 7257.4 7258.6 7260.0 7264.2 7292.4 5511.8 7056.2 7056.3 7062.5 7075.9 7515.7 7566.0 7575.3 7590.6 7596.5 4531.4 4562.9 4568.2 4568.4 4570.2 5880.4 7184.8 7192.9 7196.5 7206.7 6663.9 6956.2 6982.1 6990.4 7011.1 6954.4 6985.5 6989.3 6992.1 7007.9 6817.9 6843.8 6845.5 6852.4 6856.2 6708.1 6958.7 6963.3 6966.4 6970.8 5687.8 6516.5 6647.4 6679.8 6715.6 12:07:42 INFO - PROCESS | 6540 | 12:07:42 INFO - PROCESS | 6540 | [#5] yui.html Cycles:180 Average:18292.41 Median:35302.03 stddev:26311.59 (74.5%) stddev-sans-first:26352.17 12:07:42 INFO - PROCESS | 6540 | Values: 682.9 727.8 744.5 745.3 760.2 12441.6 14485.0 14795.9 15096.2 15111.2 13963.8 14049.7 14111.6 14123.9 14132.0 703.8 855.1 873.8 875.6 875.8 721.0 861.8 884.0 886.2 887.1 932.1 932.2 932.8 934.8 936.0 749.7 917.8 925.7 927.6 929.8 699.4 703.8 705.3 705.8 706.2 14714.6 14760.6 14786.3 14805.0 14819.0 12291.2 12407.8 12425.8 12488.9 12679.3 8297.7 9932.0 10053.8 10103.3 10304.3 3452.8 3479.7 3498.2 3532.5 3586.0 76817.0 76980.0 77039.6 77264.6 77371.0 9392.0 9476.8 9495.1 9751.6 9753.1 20922.6 21141.0 21204.0 22624.3 22625.2 7496.9 7512.1 7629.1 7771.5 7869.3 4060.0 4114.8 4155.4 4165.9 4232.7 3637.5 3695.3 3698.6 3704.4 3707.8 690.0 699.4 712.3 719.1 724.6 425.5 430.4 514.5 542.0 552.8 7763.6 7935.0 7966.0 8007.6 8275.3 578.9 581.5 596.5 601.2 604.8 3700.4 3790.9 3835.8 3845.2 3849.7 92585.0 94875.5 95299.0 95303.0 95370.5 79074.6 79415.2 81596.0 81887.0 82186.6 73207.6 73363.9 73450.6 73868.0 74607.0 6256.3 7545.5 7645.7 7651.6 7802.0 49297.8 51454.6 51544.5 51640.0 51825.0 69904.7 70129.9 70411.6 70565.0 71483.0 9914.9 10043.3 10045.8 10214.7 10476.2 10765.0 10914.3 10946.7 11177.0 11428.9 10157.8 10276.3 10322.9 10530.1 10591.3 10301.8 10564.6 10646.1 10742.7 10797.4 9963.6 10000.3 10096.2 10138.8 10258.8 7341.2 8055.9 8526.7 8528.7 8655.7 8041.6 8051.0 8669.6 8705.3 8789.9 12:07:42 INFO - PROCESS | 6540 | -------- Summary: end -------- 12:07:42 INFO - PROCESS | 6540 | 12:07:42 INFO - TEST-INFO | 6540: exit 0 12:07:42 INFO - TEST-OK | dromaeo_css | took 1114109ms 12:07:42 INFO - TEST-START | kraken 12:07:42 INFO - operating with platform_type : mac_ 12:07:42 INFO - Initialising browser for kraken test... 12:07:42 INFO - TEST-INFO | started process 6544 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmpKQJG4b/profile http://localhost:59372/getInfo.html) 12:07:44 INFO - PROCESS | 6544 | __metrics Screen width/height:1600/1200 12:07:44 INFO - PROCESS | 6544 | colorDepth:24 12:07:44 INFO - PROCESS | 6544 | Browser inner width/height: 1024/689 12:07:44 INFO - PROCESS | 6544 | __metrics 12:07:45 INFO - PROCESS | 6544 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:07:45 ERROR - PROCESS | 6544 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:07:45 INFO - TEST-INFO | 6544: exit 0 12:07:45 INFO - Browser initialized. 12:07:45 INFO - Running cycle 1/1 for kraken test... 12:07:45 INFO - TEST-INFO | started process 6546 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmpKQJG4b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:07:57 INFO - PROCESS | 6546 | RSS: Main: 243564544 12:07:57 INFO - PROCESS | 6546 | 12:08:00 INFO - PROCESS | 6546 | Cycle 1(1): loaded http://localhost:59372/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59372/tests/kraken/driver.html?testName=audio-beat-detection) 12:08:00 INFO - PROCESS | 6546 | RSS: Main: 291409920 12:08:00 INFO - PROCESS | 6546 | 12:08:03 INFO - PROCESS | 6546 | Cycle 1(1): loaded http://localhost:59372/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59372/tests/kraken/driver.html?testName=audio-dft) 12:08:04 INFO - PROCESS | 6546 | RSS: Main: 300605440 12:08:04 INFO - PROCESS | 6546 | 12:08:07 INFO - PROCESS | 6546 | Cycle 1(1): loaded http://localhost:59372/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59372/tests/kraken/driver.html?testName=audio-fft) 12:08:07 INFO - PROCESS | 6546 | RSS: Main: 286420992 12:08:07 INFO - PROCESS | 6546 | 12:08:09 INFO - PROCESS | 6546 | Cycle 1(1): loaded http://localhost:59372/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59372/tests/kraken/driver.html?testName=audio-oscillator) 12:08:10 INFO - PROCESS | 6546 | RSS: Main: 288845824 12:08:10 INFO - PROCESS | 6546 | 12:08:12 INFO - PROCESS | 6546 | Cycle 1(1): loaded http://localhost:59372/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59372/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:08:13 INFO - PROCESS | 6546 | RSS: Main: 289607680 12:08:13 INFO - PROCESS | 6546 | 12:08:15 INFO - PROCESS | 6546 | Cycle 1(1): loaded http://localhost:59372/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59372/tests/kraken/driver.html?testName=imaging-darkroom) 12:08:16 INFO - PROCESS | 6546 | RSS: Main: 288870400 12:08:16 INFO - PROCESS | 6546 | 12:08:19 INFO - PROCESS | 6546 | Cycle 1(1): loaded http://localhost:59372/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59372/tests/kraken/driver.html?testName=imaging-desaturate) 12:08:19 INFO - PROCESS | 6546 | RSS: Main: 290721792 12:08:19 INFO - PROCESS | 6546 | 12:08:22 INFO - PROCESS | 6546 | Cycle 1(1): loaded http://localhost:59372/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59372/tests/kraken/driver.html?testName=json-parse-financial) 12:08:23 INFO - PROCESS | 6546 | RSS: Main: 289525760 12:08:23 INFO - PROCESS | 6546 | 12:08:24 INFO - PROCESS | 6546 | Cycle 1(1): loaded http://localhost:59372/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59372/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:08:25 INFO - PROCESS | 6546 | RSS: Main: 323248128 12:08:25 INFO - PROCESS | 6546 | 12:08:27 INFO - PROCESS | 6546 | Cycle 1(1): loaded http://localhost:59372/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59372/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:08:27 INFO - PROCESS | 6546 | RSS: Main: 321810432 12:08:27 INFO - PROCESS | 6546 | 12:08:29 INFO - PROCESS | 6546 | Cycle 1(1): loaded http://localhost:59372/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59372/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:08:30 INFO - PROCESS | 6546 | RSS: Main: 331939840 12:08:30 INFO - PROCESS | 6546 | 12:08:33 INFO - PROCESS | 6546 | Cycle 1(1): loaded http://localhost:59372/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59372/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:08:33 INFO - PROCESS | 6546 | RSS: Main: 334589952 12:08:33 INFO - PROCESS | 6546 | 12:08:36 INFO - PROCESS | 6546 | Cycle 1(1): loaded http://localhost:59372/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59372/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:08:36 INFO - PROCESS | 6546 | RSS: Main: 334647296 12:08:36 INFO - PROCESS | 6546 | 12:08:38 INFO - PROCESS | 6546 | Cycle 1(1): loaded http://localhost:59372/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59372/tests/kraken/driver.html?testName=ai-astar) 12:08:39 INFO - PROCESS | 6546 | RSS: Main: 394776576 12:08:39 INFO - PROCESS | 6546 | 12:08:39 INFO - PROCESS | 6546 | __start_tp_report 12:08:39 INFO - PROCESS | 6546 | _x_x_mozilla_page_load 12:08:39 INFO - PROCESS | 6546 | _x_x_mozilla_page_load_details 12:08:39 INFO - PROCESS | 6546 | |i|pagename|runs| 12:08:39 INFO - PROCESS | 6546 | |0;ai-astar;153;156;141;110;111;112;118;109;108;106 12:08:39 INFO - PROCESS | 6546 | |1;audio-beat-detection;156;121;144;159;120;139;140;115;163;118 12:08:39 INFO - PROCESS | 6546 | |2;audio-dft;192;187;185;187;187;187;184;181;180;181 12:08:39 INFO - PROCESS | 6546 | |3;audio-fft;83;73;86;82;77;81;84;103;79;55 12:08:39 INFO - PROCESS | 6546 | |4;audio-oscillator;98;96;130;78;80;80;121;79;80;122 12:08:39 INFO - PROCESS | 6546 | |5;imaging-gaussian-blur;88;86;88;86;89;85;88;85;88;84 12:08:39 INFO - PROCESS | 6546 | |6;imaging-darkroom;100;94;94;92;92;94;94;94;93;93 12:08:39 INFO - PROCESS | 6546 | |7;imaging-desaturate;85;87;85;86;85;86;86;87;85;85 12:08:39 INFO - PROCESS | 6546 | |8;json-parse-financial;54;55;53;54;54;56;55;65;56;54 12:08:39 INFO - PROCESS | 6546 | |9;json-stringify-tinderbox;64;64;75;76;71;69;68;69;71;71 12:08:39 INFO - PROCESS | 6546 | |10;stanford-crypto-aes;83;83;84;82;82;83;81;80;96;106 12:08:39 INFO - PROCESS | 6546 | |11;stanford-crypto-ccm;126;132;129;108;130;132;118;120;134;127 12:08:39 INFO - PROCESS | 6546 | |12;stanford-crypto-pbkdf2;138;127;140;139;140;127;138;138;138;173 12:08:39 INFO - PROCESS | 6546 | |13;stanford-crypto-sha256-iterative;64;81;97;85;91;95;92;91;70;68 12:08:39 INFO - PROCESS | 6546 | __end_tp_report 12:08:39 INFO - PROCESS | 6546 | __start_cc_report 12:08:39 INFO - PROCESS | 6546 | _x_x_mozilla_cycle_collect,1283 12:08:39 INFO - PROCESS | 6546 | __end_cc_report 12:08:39 INFO - PROCESS | 6546 | __startTimestamp1458328119134__endTimestamp 12:08:39 INFO - PROCESS | 6546 | 12:08:39 INFO - PROCESS | 6546 | ------- Summary: start ------- 12:08:39 INFO - PROCESS | 6546 | Number of tests: 14 12:08:39 INFO - PROCESS | 6546 | 12:08:39 INFO - PROCESS | 6546 | [#0] ai-astar Cycles:10 Average:122.40 Median:115.00 stddev:19.66 (17.1%) stddev-sans-first:17.46 12:08:39 INFO - PROCESS | 6546 | Values: 153.0 156.0 141.0 110.0 111.0 112.0 118.0 109.0 108.0 106.0 12:08:39 INFO - PROCESS | 6546 | 12:08:39 INFO - PROCESS | 6546 | [#1] audio-beat-detection Cycles:10 Average:137.50 Median:142.00 stddev:18.17 (12.8%) stddev-sans-first:17.99 12:08:39 INFO - PROCESS | 6546 | Values: 156.0 121.0 144.0 159.0 120.0 139.0 140.0 115.0 163.0 118.0 12:08:39 INFO - PROCESS | 6546 | 12:08:39 INFO - PROCESS | 6546 | [#2] audio-dft Cycles:10 Average:185.10 Median:187.00 stddev:3.70 (2.0%) stddev-sans-first:2.96 12:08:39 INFO - PROCESS | 6546 | Values: 192.0 187.0 185.0 187.0 187.0 187.0 184.0 181.0 180.0 181.0 12:08:39 INFO - PROCESS | 6546 | 12:08:39 INFO - PROCESS | 6546 | [#3] audio-fft Cycles:10 Average:80.30 Median:81.50 stddev:11.92 (14.6%) stddev-sans-first:12.60 12:08:39 INFO - PROCESS | 6546 | Values: 83.0 73.0 86.0 82.0 77.0 81.0 84.0 103.0 79.0 55.0 12:08:39 INFO - PROCESS | 6546 | 12:08:39 INFO - PROCESS | 6546 | [#4] audio-oscillator Cycles:10 Average:96.40 Median:80.00 stddev:20.66 (25.8%) stddev-sans-first:21.90 12:08:39 INFO - PROCESS | 6546 | Values: 98.0 96.0 130.0 78.0 80.0 80.0 121.0 79.0 80.0 122.0 12:08:39 INFO - PROCESS | 6546 | 12:08:39 INFO - PROCESS | 6546 | [#5] imaging-gaussian-blur Cycles:10 Average:86.70 Median:88.00 stddev:1.70 (1.9%) stddev-sans-first:1.74 12:08:39 INFO - PROCESS | 6546 | Values: 88.0 86.0 88.0 86.0 89.0 85.0 88.0 85.0 88.0 84.0 12:08:39 INFO - PROCESS | 6546 | 12:08:39 INFO - PROCESS | 6546 | [#6] imaging-darkroom Cycles:10 Average:94.00 Median:94.00 stddev:2.26 (2.4%) stddev-sans-first:0.87 12:08:39 INFO - PROCESS | 6546 | Values: 100.0 94.0 94.0 92.0 92.0 94.0 94.0 94.0 93.0 93.0 12:08:39 INFO - PROCESS | 6546 | 12:08:39 INFO - PROCESS | 6546 | [#7] imaging-desaturate Cycles:10 Average:85.70 Median:86.00 stddev:0.82 (1.0%) stddev-sans-first:0.83 12:08:39 INFO - PROCESS | 6546 | Values: 85.0 87.0 85.0 86.0 85.0 86.0 86.0 87.0 85.0 85.0 12:08:39 INFO - PROCESS | 6546 | 12:08:39 INFO - PROCESS | 6546 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:55.00 stddev:3.44 (6.3%) stddev-sans-first:3.60 12:08:39 INFO - PROCESS | 6546 | Values: 54.0 55.0 53.0 54.0 54.0 56.0 55.0 65.0 56.0 54.0 12:08:39 INFO - PROCESS | 6546 | 12:08:39 INFO - PROCESS | 6546 | [#9] json-stringify-tinderbox Cycles:10 Average:69.80 Median:71.00 stddev:3.97 (5.6%) stddev-sans-first:3.61 12:08:39 INFO - PROCESS | 6546 | Values: 64.0 64.0 75.0 76.0 71.0 69.0 68.0 69.0 71.0 71.0 12:08:39 INFO - PROCESS | 6546 | 12:08:39 INFO - PROCESS | 6546 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:83.00 stddev:8.33 (10.0%) stddev-sans-first:8.76 12:08:39 INFO - PROCESS | 6546 | Values: 83.0 83.0 84.0 82.0 82.0 83.0 81.0 80.0 96.0 106.0 12:08:39 INFO - PROCESS | 6546 | 12:08:39 INFO - PROCESS | 6546 | [#11] stanford-crypto-ccm Cycles:10 Average:125.60 Median:129.50 stddev:8.06 (6.2%) stddev-sans-first:8.55 12:08:39 INFO - PROCESS | 6546 | Values: 126.0 132.0 129.0 108.0 130.0 132.0 118.0 120.0 134.0 127.0 12:08:39 INFO - PROCESS | 6546 | 12:08:39 INFO - PROCESS | 6546 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.80 Median:138.50 stddev:12.66 (9.1%) stddev-sans-first:13.42 12:08:39 INFO - PROCESS | 6546 | Values: 138.0 127.0 140.0 139.0 140.0 127.0 138.0 138.0 138.0 173.0 12:08:39 INFO - PROCESS | 6546 | 12:08:39 INFO - PROCESS | 6546 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:83.40 Median:91.00 stddev:12.07 (13.3%) stddev-sans-first:10.56 12:08:39 INFO - PROCESS | 6546 | Values: 64.0 81.0 97.0 85.0 91.0 95.0 92.0 91.0 70.0 68.0 12:08:39 INFO - PROCESS | 6546 | -------- Summary: end -------- 12:08:39 INFO - PROCESS | 6546 | 12:08:39 INFO - TEST-INFO | 6546: exit 0 12:08:39 INFO - TEST-OK | kraken | took 56974ms 12:08:39 INFO - SUITE-END | took 1171s 12:08:40 INFO - Completed test suite (00:19:31) 12:08:40 INFO - javascript benchmark 12:08:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3381.8985430437087, 3423.7261019118473, 3461.8269086545665, 3465.6187819339884, 3504.7371447141472, 4888.486708895563, 5328.520433161015, 5621.269234999444, 5678.176664383662, 5688.3458402283695, 5587.161925711145, 5644.153376993453, 5652.0391533439315, 5666.348369937458, 5682.0056490114275, 5126.307948426952, 5152.536271735543, 5167.405748338932, 5195.454477279888, 5242.292290540767, 5236.685798852062, 5259.86850328741, 5260.0268950244135, 5263.0263401270695, 5274.314339135907, 5092.0, 5128.794848206067, 5154.536091751742, 5167.48325167484, 5245.4754524547625, 5199.402068762084, 5211.791528338862, 5236.764345604457, 5240.344956880409, 5292.126799078147, 3811.7141214408753, 5100.438951715309, 5110.744462776884, 5157.097507936133, 5211.400688920785, 5554.166874968747, 5563.221149039137, 5598.0, 5603.131514615241, 5668.149777533362, 5443.863903402446, 6197.349278325756, 6212.099245609361, 6225.906611400833, 6246.0, 6120.203342909613, 6124.0, 6206.6586337751405, 6224.439800417938, 6237.220347456568, 5808.5933984621515, 5814.156947242626, 5840.561957853178, 5842.269716285465, 5843.620164689281, 6189.102580125947, 6248.750049997949, 6260.874782504325, 6270.843228919313, 6275.058741188767, 6012.188354572077, 6026.035834266497, 6092.421219984094, 6132.324915438597, 6159.4456498915315, 6170.660613666291, 6220.657863817443, 6232.688365581703, 6253.062040693932, 6257.217847769029, 6204.348543402968, 6207.96896015517, 6210.130581718563, 6223.315435302113, 6223.439890409885, 5714.542836573064, 6107.114468402146, 6169.598976066542, 6196.349383314777, 6234.064890266496, 4884.755762211947, 4888.193448081098, 4894.0730771148565, 4898.461169271377, 4912.484189160158, 4411.933820992687, 4415.977920110379, 4438.245498265238, 4448.266036104072, 4472.664550158751, 5639.492445679908, 5683.630564013326, 5701.828945131652, 5793.797217097382, 5811.070228763378, 6162.127139973639, 6197.876042479125, 6222.191115155001, 6228.252609686867, 6231.158793562811, 5759.942400576025, 5763.567732420001, 5784.595078344475, 5787.074068149076, 5790.073588225948, 5266.1574148136115, 5330.333708286465, 5391.514763671288, 5397.865053373697, 5457.317835270591, 6327.367263273728, 6344.714487848058, 6353.777617783356, 6366.840828979312, 6380.680965951591, 6133.487685122479, 6221.844453888689, 6228.0, 6228.968855155696, 6231.9688401557705, 6220.844478887883, 6254.499640028877, 6271.592346497463, 6293.056041593798, 6307.306196318493, 5208.3229180207845, 6105.0, 6140.263168419819, 6149.661768602591, 6179.474744646575, 6098.43222861686, 6146.754129834757, 6245.594036387621, 6245.812625621239, 6267.467265282502, 5497.092979658311, 6023.6385816851125, 6122.142899994094, 6168.290646575701, 6190.2571691397325, 5899.439553242435, 6149.538784591263, 6154.353792851686, 6155.0151975683675, 6159.907601385893, 5886.882262354815, 5992.730327135202, 6036.215292012011, 6038.818835434944, 6081.422264884829, 6004.759809607567, 6040.788572399945, 6077.604955677867, 6120.699964124781, 6149.84625384369, 5976.043832986701, 6001.549883758823, 6005.189299444519, 6016.909746353721, 6024.638521688713], "unit": "score", "name": "dojo.html", "value": 5668.328066389703}, {"lowerIsBetter": false, "replicates": [450.2952878744766, 537.0789096699162, 571.8677019501386, 579.3887448741576, 634.3402861024534, 36831.631683683154, 38724.80637596808, 38848.805755971254, 38860.0, 38904.0, 40704.98237544063, 41017.0, 41179.38230926531, 41185.7940710296, 41233.0, 9416.199623032051, 9616.711498655051, 9640.42157470554, 9655.5172241388, 9665.710028699115, 9519.0, 9714.902850971506, 9717.56270967808, 9720.805583888317, 9727.367721098106, 9695.127438530531, 9767.218622510218, 9774.266929980244, 9778.217742580577, 9788.951055244714, 9632.903670963306, 9705.0, 9721.416714997053, 9737.123658870736, 9742.902570974271, 9592.760180995461, 9731.270154738422, 9744.31789774716, 9744.853827192597, 9751.36616119957, 33265.334693305995, 39875.20249595021, 40297.79851100755, 40345.59654403477, 40367.99080023023, 2369.6919400478, 3186.85659145339, 3204.2630195055035, 3206.9518957215428, 3333.833308334598, 27933.0, 28153.43693126126, 28251.293717657016, 28377.85811070952, 28973.42053158925, 2735.8084934054623, 2739.068716636353, 2755.1596762987283, 2850.586664933573, 2902.985485072561, 413436.93281533703, 416791.0, 417904.999999997, 419241.8075819233, 421079.0, 60430.39569604336, 67423.66288168626, 67747.0, 68256.6587167061, 68374.0, 62818.0, 63965.68017159885, 74281.20047395054, 75075.24924750683, 75109.0, 17193.828061719472, 17198.054107023985, 17323.740143897852, 17349.2192851322, 17355.21901514435, 11876.287422754662, 12933.353332333345, 12994.935025324812, 13027.804582931263, 13033.543825966235, 21478.637349891498, 21980.560388792135, 22006.779932200792, 22023.33929982071, 22064.117435302407, 9127.954360228288, 9415.15263626277, 9419.481928493999, 9430.62277508892, 9447.001154267089, 997.0627610046533, 1000.7240768020831, 1038.9688309350731, 1083.9702282831342, 1148.7530181010954, 24892.626610600855, 29486.557701634065, 29969.100926972227, 30193.547096793565, 30386.54420183699, 1010.4796030044386, 1046.6546039806844, 1084.1218612923558, 1203.464458316041, 1237.2638280223252, 14727.337269822883, 14746.852531474762, 14852.683976859924, 14880.776788348183, 15051.322690478955, 432816.0, 437457.0, 442128.0, 443566.0, 444248.0, 57848.42151578514, 58242.7087864558, 58267.70866145642, 58285.417145827996, 58567.70716146392, 1345.5559665310425, 1460.8247010358612, 1467.3250304859885, 1504.9021813582083, 1517.6205948512873, 27240.455190895675, 28559.571606426336, 28800.0, 29283.0, 29454.705452945196, 47015.05969880515, 47250.0, 47374.526254737015, 47523.524764751906, 47530.0, 272679.0, 276537.0, 276555.0, 276748.0, 276900.0, 28981.42037159287, 33216.50175247325, 34447.65552344545, 34502.30995380128, 34532.82733586417, 41296.587034129276, 42099.158016840105, 42477.57522424736, 42551.148977019664, 42949.0, 27529.31176720598, 35417.64582354143, 36153.096172594844, 36164.27671446609, 36481.63518364782, 34612.82693586516, 34998.650013500555, 35825.283494329444, 35926.820365898006, 36346.8182659085, 35706.821465892506, 36764.63235367719, 36815.63184368122, 37050.25899482049, 37367.6263237375, 31863.03827751159, 31940.041798746075, 32230.35539289248, 32320.676793231767, 32718.34563308768, 24239.03043878225, 24258.393540161636, 24411.51176976486, 24494.63258051095, 24663.63004554969], "unit": "score", "name": "ext.html", "value": 19375.338088130906}, {"lowerIsBetter": false, "replicates": [355.67455777963164, 360.6321552016943, 361.19273423897585, 369.59160128058494, 370.3944051475836, 19513.512162195933, 20143.59712805745, 21017.159313627435, 21534.89232553839, 21536.0, 18746.531336716587, 18925.432237032877, 19349.516262093453, 19545.51136221595, 19570.06449032646, 5209.244659524366, 5334.893302133974, 5342.252084708144, 5376.166694162411, 5382.730863456831, 3861.131245469761, 4040.939385909214, 5287.735613219343, 5623.606347555673, 5913.9112913306335, 5866.090755932816, 5895.646261224319, 5898.0, 5904.527637788967, 5905.970470147643, 5625.128105143709, 5711.942880571203, 5810.796622118248, 5819.0689489681445, 5894.469497745202, 5544.085225937715, 5549.445055494418, 5556.583256255797, 5563.860903477445, 5580.581456390787, 15547.378104875792, 23423.297301080995, 24002.879985600135, 24221.273361799173, 24294.635580466307, 1983.633027889845, 2022.0395312226574, 2097.5595125023765, 2161.6001039807684, 2173.119886445992, 9255.768605784842, 9850.901490985141, 10086.394816311045, 10103.19174466041, 10153.194669323702, 1634.411611819744, 1709.623882745794, 1744.0930716027722, 1759.9648007039916, 1809.2039502618807, 89843.0, 92052.53973730156, 92506.53746731291, 92683.60974585454, 92784.53607731986, 10952.4523773811, 11134.443277836075, 11167.441627918734, 11195.384253866116, 11327.603533876274, 13442.193468391928, 13535.120217185851, 13535.864641353657, 13565.728685426237, 13574.0, 8406.075331713506, 8497.150284971452, 8533.530655813865, 8620.0, 8675.04811417426, 8566.61450234741, 8574.0, 8614.05245423003, 8730.38887277897, 8737.956310218535, 3907.3552863777727, 4184.895377615584, 4458.464984201852, 4466.2630665940405, 4486.282194848874, 1725.5254804928745, 1787.6335351252962, 1851.7037274036359, 1870.2238570992886, 1884.406411980222, 917.206616276929, 931.7111695374456, 946.7491114854569, 998.8413440409236, 1028.5217373921162, 17932.91033544824, 18429.447116586525, 18739.531511712317, 18748.25006999732, 18924.24303027891, 930.2325581395376, 967.6468089147411, 987.7530617345664, 989.2877128467636, 1012.372329155928, 10152.340097893613, 10184.185265178769, 10221.43782091992, 10227.846582301272, 10241.539130739135, 584740.0, 594521.0, 596399.0, 603204.0, 605584.0, 98899.47396553958, 102697.0, 103779.0, 105833.47083264688, 107287.0, 1022.2128960700368, 1034.7464871106627, 1045.1168762395764, 1046.4244665434132, 1052.5211028981641, 14133.505327313494, 16998.175410533026, 17296.308147673953, 17359.739603906204, 17455.304945686166, 45722.08555828931, 46397.536024639325, 46860.7656961713, 47596.7620161897, 48039.75980120077, 47295.0, 62094.44763880939, 65831.0, 67351.65296694137, 69002.65498672475, 7613.961930190314, 7669.463137580316, 7825.765227043198, 7852.528848269122, 7854.2145785421, 10617.362958222531, 12015.879841201477, 12127.81808272859, 12165.219258600842, 12297.200681955645, 10499.94750026245, 10560.155187584822, 10693.037626613332, 10741.570337186426, 10886.945565272123, 9465.290103242147, 9782.266330025419, 10346.793064138825, 10447.320924139907, 10619.1504679627, 10639.521221545205, 10730.839037414602, 10935.507902144582, 10971.0, 11032.22774405816, 6475.708593113227, 7597.582132982739, 7664.233576642291, 7771.766846994599, 7991.600419979094, 10066.94966525192, 10562.841557376492, 10782.406967616856, 10839.078678312431, 10841.0], "unit": "score", "name": "jquery.html", "value": 8999.208482112663}, {"lowerIsBetter": false, "replicates": [1454.905431146976, 1590.4194968836375, 1615.741481362982, 1887.5469887227061, 2027.6147531968925, 7971.720989765359, 8620.482771033743, 8809.163129502704, 8809.163129502704, 8816.382853200279, 8376.916230837689, 8623.094575069621, 8623.439476434027, 8635.13648635136, 8636.524991125485, 2168.793964573363, 2399.700037495313, 2457.152282462552, 2465.2604218734396, 2486.5648511510412, 2439.7682220189054, 2440.670509481224, 2441.5971364724887, 2444.5721998650165, 2449.2529778417575, 2418.6855708757835, 2453.1904471524354, 2483.1004281724495, 2483.8261321707487, 2484.6397272395493, 2448.7061552613714, 2461.4092617771785, 2469.604863221885, 2481.727010028895, 2487.763662452064, 2420.261820144855, 2444.792192663608, 2445.0708730682404, 2447.865367404792, 2459.090136649433, 8690.782730431727, 8784.253338466238, 8803.911960880374, 8805.867911981326, 8821.911780882174, 5417.729113544347, 5558.082916318803, 5568.52667523261, 5569.805056822992, 5583.720813959327, 3552.2007548301685, 3672.7796332219887, 3709.1098136447326, 3726.9068273293383, 3733.4213196954242, 1018.5365658625308, 1031.9535620897077, 1039.5893622019335, 1047.7171163785736, 1047.9423631700254, 11903.94048029763, 11913.225640333438, 11913.404329783476, 11913.583024594098, 11920.582779602759, 4228.0, 4831.178699621002, 4886.462489126193, 4890.510948905152, 4951.430585482643, 9954.651587194414, 10004.899951000396, 10027.498625068718, 10045.79908401828, 10048.447335396624, 5548.69482178476, 5549.139883318092, 5551.056320425538, 5552.833414997556, 5558.0, 4473.575010374009, 4595.471520775087, 4880.292357608198, 4933.333999909966, 4994.825181118644, 3846.4230365444846, 3935.370340745467, 3943.7042221833476, 3956.1999290322833, 3967.78177200251, 1284.563248495516, 1298.7077907470743, 1303.328785675378, 1317.631063302277, 1320.821689071963, 1320.9867901320863, 1352.48605529898, 1359.9932000340134, 1370.9657258568616, 1373.684052667892, 8180.14108518597, 8185.3451723861945, 8206.712765053195, 8226.177382261725, 8237.958810205912, 460.99078018439445, 486.6544753225179, 490.7374554613265, 491.2851800630146, 494.1352632892438, 5947.37552556984, 6143.508519318444, 6194.628322300587, 6218.626882387071, 6222.3466536013975, 10422.583096676048, 10713.517891694892, 10729.409882456539, 10852.131829453625, 10871.239013268996, 10414.947925260325, 10616.097631701237, 10687.091597214323, 10712.35725856451, 10734.892651073389, 8138.918610813935, 8189.344852411674, 8267.379946504036, 8271.33829293655, 8359.874601880976, 7806.258405451473, 7849.8037549059445, 7852.568108754073, 7877.291043806085, 7906.52560846351, 9466.810663786824, 9596.568154432927, 9611.759706007406, 9663.27525435581, 9729.173020293354, 9856.31005829585, 9895.455749933823, 9902.0, 9925.553350099119, 10046.69859904204, 6675.332466753286, 6888.138982627172, 7324.670389832364, 7399.741009064657, 7485.1766305707415, 8112.351011918914, 8136.06435259929, 8158.755237342889, 8176.386770992318, 8188.0, 7215.783526494213, 7259.782206533812, 7289.744858929912, 7404.703811847681, 7441.702331906879, 7169.856602868018, 7222.313880181375, 7248.710051597877, 7260.709571617076, 7306.2693730626515, 7623.771286861182, 7714.11287701899, 7715.884261735966, 7724.343430808444, 7734.1105772836845, 6951.7914462566205, 6973.372396484341, 7056.54132481387, 7065.187503437171, 7065.505414620927, 7113.82215444618, 7169.354758071799, 7171.820704482429, 7177.820554486179, 7186.7125314986815], "unit": "score", "name": "mootools.html", "value": 4837.707661853044}, {"lowerIsBetter": false, "replicates": [321.60763868080943, 324.9350129974004, 328.70252421558496, 330.3904296572823, 334.83927714696944, 5461.743798926249, 6540.084388185652, 6545.869082618345, 6603.603783772971, 6652.0, 6485.254195767488, 6520.152380190569, 6525.771597994071, 6533.444657204143, 6533.607983520992, 4318.827246910136, 4336.4362632857765, 4704.153252414564, 4724.834630787923, 4763.118823017753, 4120.423140760281, 4701.788419521113, 4829.975850120744, 4849.636277279201, 4876.4148302203785, 4782.13921494131, 4793.784279707422, 4799.520047995207, 4823.34884790554, 4830.299606557047, 4564.338170965208, 4622.0, 4755.952440475586, 4798.136335459616, 4822.107910036654, 4100.938485922714, 4118.094019315746, 4119.990602302425, 4132.876013719593, 4150.605692459211, 5680.971595142039, 6228.844278893019, 6282.089097080943, 6310.873782524323, 6320.74717011319, 5611.410801865786, 5612.550995920357, 5614.747336369873, 5626.9437305626825, 5633.408492108351, 6919.792406227822, 6920.446364290895, 6929.376356127922, 6930.20302665195, 6932.826679333007, 4488.124815660947, 4608.723476591415, 4658.58072773452, 4660.997885454643, 4716.740579268139, 6974.755883544051, 7032.542884712478, 7073.469489788286, 7077.398421134261, 7080.433565314763, 4691.9530804692195, 4696.412948381452, 4704.458987216445, 4708.270218116198, 4720.150372932905, 4395.494518130456, 4769.974455492016, 4773.734960235541, 4795.712257264575, 4863.468007577601, 5561.527270181999, 5565.860853478695, 5581.804636837691, 5584.720763961785, 5599.720013999284, 6607.482751902119, 6744.595324280559, 6838.281980392087, 6848.657567121624, 6877.3810357067105, 1472.786445965329, 1665.392131871858, 1695.1947824783128, 1695.4998275508754, 1698.9235484402984, 1084.159776173456, 1087.2986923434341, 1103.1395511501041, 1117.3910218930703, 1121.8317252412203, 6355.586886852339, 6488.383603557654, 6554.573952693059, 6618.602883826986, 6655.73377064912, 5922.851928701731, 6746.460283177334, 7311.0495635568095, 7312.670929808171, 7317.6217729238215, 5452.509274165265, 6597.505187110986, 6608.636524991171, 6641.0, 6643.202815662152, 3802.6767724743154, 3848.8460461581785, 3851.0372406898277, 3851.537815462106, 3851.7496362736333, 7220.566765994057, 7379.852402951911, 7493.4005279577505, 7500.624968751541, 7560.470767046254, 7463.029806125169, 7495.362894153949, 7506.662200201004, 7513.661885215069, 7522.811929701801, 6178.567500274938, 7559.470837041355, 7571.9777829993345, 7580.279873412017, 7597.126330471956, 7257.383122434652, 7258.637068146677, 7259.963700181465, 7264.200937896932, 7292.380147687506, 5511.779528818803, 7056.223815380202, 7056.259092795182, 7062.540934839219, 7075.893861592183, 7515.736949206752, 7565.962170189114, 7575.318221360104, 7590.620468976419, 7596.506227095221, 4531.365608814835, 4562.908741825211, 4568.2005649010625, 4568.383268258743, 4570.200214962435, 5880.353161152184, 7184.784456466315, 7192.928070719226, 7196.452762656054, 7206.7117315306805, 6663.866722665616, 6956.165260168812, 6982.092327997328, 6990.370866622028, 7011.053507776385, 6954.408875245661, 6985.545939513915, 6989.26612705679, 6992.1259842519685, 7007.929920700728, 6817.93182068173, 6843.828904277234, 6845.452363810983, 6852.417544508772, 6856.24581296047, 6708.127943367331, 6958.652067396712, 6963.268856770169, 6966.442684585322, 6970.79087627372, 5687.829365119053, 6516.5112616553, 6647.401733843977, 6679.833004174934, 6715.563488373436], "unit": "score", "name": "prototype.html", "value": 5078.0063943470695}, {"lowerIsBetter": false, "replicates": [682.856600113976, 727.7962170592236, 744.4788647946439, 745.2584678245145, 760.2017881224713, 12441.55638323163, 14485.0, 14795.926020369896, 15096.245187740624, 15111.168885711282, 13963.790543141835, 14049.719005619882, 14111.576652700409, 14123.858761412383, 14132.0, 703.8240439890028, 855.102142750113, 873.7815546113471, 875.6366108065178, 875.763543843162, 721.0, 861.7673228228375, 884.0364003236471, 886.2112719679491, 887.0685779931079, 932.0912110692088, 932.235566835192, 932.7807965128223, 934.8364036293656, 936.0312077000306, 749.7375918428561, 917.7751450894574, 925.726910561386, 927.5501381829807, 929.7907970706605, 699.4020112803581, 703.8345988692653, 705.3193668110247, 705.8447141628833, 706.1808302369227, 14714.558563243012, 14760.63098422548, 14786.260686965608, 14805.037672551358, 14818.96267261292, 12291.201071930296, 12407.75184496314, 12425.813612795815, 12488.937555312255, 12679.302638354888, 8297.668093276323, 9932.006799320083, 10053.849192262122, 10103.343282686676, 10304.278700490968, 3452.781074531008, 3479.7216222702377, 3498.230389314372, 3532.4701294805727, 3585.9641403585892, 76816.99999999945, 76980.0, 77039.61480192619, 77264.61367693126, 77371.0, 9391.953040234755, 9476.810463790824, 9495.14543691071, 9751.561179746928, 9753.073458021476, 20922.581548368948, 21141.0, 21204.04581793823, 22624.321270361914, 22625.2081177158, 7496.850062998818, 7512.13610434807, 7629.0845098588525, 7771.494852834548, 7869.331106855867, 4059.9594004060173, 4114.814833332507, 4155.4182414462, 4165.937510937339, 4232.682548808852, 3637.5089362935664, 3695.3163664721574, 3698.6116457772087, 3704.388775852008, 3707.8146092695256, 689.975850845218, 699.4055053204735, 712.2877122877123, 719.0939416335455, 724.6123324021623, 425.47241420638187, 430.4382780471452, 514.477805027897, 542.0487045235586, 552.7733629212004, 7763.60266056048, 7935.0, 7966.0, 8007.599620018976, 8275.296599789086, 578.9015867302569, 581.4824805922732, 596.5049009322252, 601.2424345324922, 604.7732100462326, 3700.4449332600325, 3790.9241815164096, 3835.8082095895093, 3845.2309538091936, 3849.6920246380223, 92585.0, 94875.52562237282, 95299.0, 95303.0, 95370.5231473852, 79074.60462697649, 79415.20584794194, 81596.0, 81887.0, 82186.58906705548, 73207.63396183091, 73363.89954150692, 73450.63274683592, 73868.0, 74607.0, 6256.289668503486, 7545.50954187976, 7645.732399366218, 7651.579163146081, 7802.0, 49297.753511232215, 51454.56817897763, 51544.48455515397, 51640.0, 51825.0, 69904.6504767473, 70129.89610311699, 70411.64794175996, 70565.0, 71483.0, 9914.900850991398, 10043.296969212377, 10045.849312260469, 10214.693559193236, 10476.161907047266, 10765.013457510746, 10914.345139291669, 10946.671599852018, 11177.0, 11428.885711142782, 10157.79684406293, 10276.280660353703, 10322.948385258025, 10530.05229529346, 10591.258611897401, 10301.793964120825, 10564.630237941636, 10646.095081917814, 10742.677719668422, 10797.352158870493, 9963.551640176354, 10000.349977251455, 10096.242781791248, 10138.847917281098, 10258.846117308396, 7341.155767086853, 8055.919440805751, 8526.658933642833, 8528.658853645784, 8655.6970506032, 8041.597920103854, 8051.0, 8669.60986755585, 8705.260052895575, 8789.91210087891], "unit": "score", "name": "yui.html", "value": 6716.832216853026}], "name": "dromaeo_css", "value": 7391.62811834333}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [153.0, 156.0, 141.0, 110.0, 111.0, 112.0, 118.0, 109.0, 108.0, 106.0], "unit": "score", "name": "ai-astar", "value": 122.4}, {"lowerIsBetter": true, "replicates": [156.0, 121.0, 144.0, 159.0, 120.0, 139.0, 140.0, 115.0, 163.0, 118.0], "unit": "score", "name": "audio-beat-detection", "value": 137.5}, {"lowerIsBetter": true, "replicates": [192.0, 187.0, 185.0, 187.0, 187.0, 187.0, 184.0, 181.0, 180.0, 181.0], "unit": "score", "name": "audio-dft", "value": 185.1}, {"lowerIsBetter": true, "replicates": [83.0, 73.0, 86.0, 82.0, 77.0, 81.0, 84.0, 103.0, 79.0, 55.0], "unit": "score", "name": "audio-fft", "value": 80.3}, {"lowerIsBetter": true, "replicates": [98.0, 96.0, 130.0, 78.0, 80.0, 80.0, 121.0, 79.0, 80.0, 122.0], "unit": "score", "name": "audio-oscillator", "value": 96.4}, {"lowerIsBetter": true, "replicates": [88.0, 86.0, 88.0, 86.0, 89.0, 85.0, 88.0, 85.0, 88.0, 84.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 86.7}, {"lowerIsBetter": true, "replicates": [100.0, 94.0, 94.0, 92.0, 92.0, 94.0, 94.0, 94.0, 93.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 94.0}, {"lowerIsBetter": true, "replicates": [85.0, 87.0, 85.0, 86.0, 85.0, 86.0, 86.0, 87.0, 85.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 85.7}, {"lowerIsBetter": true, "replicates": [54.0, 55.0, 53.0, 54.0, 54.0, 56.0, 55.0, 65.0, 56.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 55.6}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 75.0, 76.0, 71.0, 69.0, 68.0, 69.0, 71.0, 71.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.8}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 84.0, 82.0, 82.0, 83.0, 81.0, 80.0, 96.0, 106.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.0}, {"lowerIsBetter": true, "replicates": [126.0, 132.0, 129.0, 108.0, 130.0, 132.0, 118.0, 120.0, 134.0, 127.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.6}, {"lowerIsBetter": true, "replicates": [138.0, 127.0, 140.0, 139.0, 140.0, 127.0, 138.0, 138.0, 138.0, 173.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 139.8}, {"lowerIsBetter": true, "replicates": [64.0, 81.0, 97.0, 85.0, 91.0, 95.0, 92.0, 91.0, 70.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 83.4}], "name": "kraken", "value": 1448.3}]} 12:08:40 INFO - Return code: 0 12:08:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:08:40 ERROR - # TBPL SUCCESS # 12:08:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:08:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:08:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:08:40 INFO - 2016-03-18 12:08:40.460 screenresolution[6550:121056] starting screenresolution argv=screenresolution get 12:08:40 INFO - 2016-03-18 12:08:40.463 screenresolution[6550:121056] Display 0: 1600x1200x32@60 12:08:40 INFO - 2016-03-18 12:08:40.469 screenresolution[6551:121059] starting screenresolution argv=screenresolution list 12:08:40 INFO - Available Modes on Display 0 12:08:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:08:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:08:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:08:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:08:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:08:40 INFO - Intel Iris: 12:08:40 INFO - Chipset Model: Intel Iris 12:08:40 INFO - Type: GPU 12:08:40 INFO - Bus: Built-In 12:08:40 INFO - VRAM (Dynamic, Max): 1536 MB 12:08:40 INFO - Vendor: Intel (0x8086) 12:08:40 INFO - Device ID: 0x0a2e 12:08:40 INFO - Revision ID: 0x0009 12:08:40 INFO - Displays: 12:08:40 INFO - Display: 12:08:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:08:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:08:40 INFO - Display Serial Number: 1600x1200 60 12:08:40 INFO - Main Display: Yes 12:08:40 INFO - Mirror: Off 12:08:40 INFO - Online: Yes 12:08:40 INFO - Rotation: Supported 12:08:40 INFO - Return code: 0 12:08:40 INFO - Running post-action listener: _resource_record_post_action 12:08:40 INFO - Running post-run listener: _resource_record_post_run 12:08:41 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 2469888; Write bytes: 703958016; Read time: 45; Write time: 1926 12:08:41 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 402352640; Write bytes: 404170240; Read time: 31208; Write time: 792 12:08:41 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 2469888; Write bytes: 298939904; Read time: 45; Write time: 1131 12:08:41 INFO - Running post-run listener: _upload_blobber_files 12:08:41 INFO - Blob upload gear active. 12:08:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:08:41 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 12:08:41 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'] 12:08:41 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 12:08:42 INFO - (blobuploader) - INFO - Open directory for files ... 12:08:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:08:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:08:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:08:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:08:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:08:43 INFO - (blobuploader) - INFO - Done attempting. 12:08:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:08:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:08:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:08:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:08:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:08:43 INFO - (blobuploader) - INFO - Done attempting. 12:08:43 INFO - (blobuploader) - INFO - Iteration through files over. 12:08:44 INFO - Return code: 0 12:08:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:08:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:08:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bd68d4244f352427d059adb6655bdb770c5d2d1f3fd6c666bedd5a6a1731ae6e68d7d80c04d07a5a8bbc8f058c3bb29fa79be5a046f206216a660b93546abb3a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/12badde6039c79e2d27f2f4c1d656c22e3acd2d3a5a755ef2ac5af6b9e01ea1b0f2ab7578b505a2a2ce868d6fa4a6339004915fdff4b087bad62a57ee9b45562"} 12:08:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:08:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:08:44 INFO - Contents: 12:08:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bd68d4244f352427d059adb6655bdb770c5d2d1f3fd6c666bedd5a6a1731ae6e68d7d80c04d07a5a8bbc8f058c3bb29fa79be5a046f206216a660b93546abb3a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/12badde6039c79e2d27f2f4c1d656c22e3acd2d3a5a755ef2ac5af6b9e01ea1b0f2ab7578b505a2a2ce868d6fa4a6339004915fdff4b087bad62a57ee9b45562"} 12:08:44 INFO - Running post-run listener: copy_logs_to_upload_dir 12:08:44 INFO - Copying logs to upload dir... 12:08:44 INFO - mkdir: /builds/slave/test/build/upload/logs 12:08:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.986487 ========= master_lag: 11.92 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-03-18 12:08:55.948277) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-18 12:08:55.949211) ========= 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.0N1Y1L62Ke/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.noqIWM6oJS/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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/bd68d4244f352427d059adb6655bdb770c5d2d1f3fd6c666bedd5a6a1731ae6e68d7d80c04d07a5a8bbc8f058c3bb29fa79be5a046f206216a660b93546abb3a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/12badde6039c79e2d27f2f4c1d656c22e3acd2d3a5a755ef2ac5af6b9e01ea1b0f2ab7578b505a2a2ce868d6fa4a6339004915fdff4b087bad62a57ee9b45562"} build_url:https://queue.taskcluster.net/v1/task/XTG0GOXhSASlgG41JAt3Ag/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011145 build_url: 'https://queue.taskcluster.net/v1/task/XTG0GOXhSASlgG41JAt3Ag/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bd68d4244f352427d059adb6655bdb770c5d2d1f3fd6c666bedd5a6a1731ae6e68d7d80c04d07a5a8bbc8f058c3bb29fa79be5a046f206216a660b93546abb3a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/12badde6039c79e2d27f2f4c1d656c22e3acd2d3a5a755ef2ac5af6b9e01ea1b0f2ab7578b505a2a2ce868d6fa4a6339004915fdff4b087bad62a57ee9b45562"}' ========= master_lag: 0.54 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-18 12:08:56.502759) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 8 secs) (at 2016-03-18 12:08:56.503046) ========= 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.0N1Y1L62Ke/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.noqIWM6oJS/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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.005284 ========= master_lag: 8.61 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 8 secs) (at 2016-03-18 12:09:05.121066) ========= ========= Started reboot skipped (results: 3, elapsed: 3 secs) (at 2016-03-18 12:09:05.121341) ========= ========= Finished reboot skipped (results: 3, elapsed: 3 secs) (at 2016-03-18 12:09:08.709993) ========= ========= Total master_lag: 21.32 =========