builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0168 starttime: 1456334528.27 results: success (0) buildid: 20160224082844 builduid: b35ed84b2eda4fcb882520d41f72eab5 revision: 254c6ce06541ff04ed083dbc58623a4a2cebb110 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-24 09:22:08.268157) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-24 09:22:08.268581) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-24 09:22:08.268878) ========= 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.z5r4gQeHn3/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.n8ooadwoVf/Listeners TMPDIR=/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/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.005419 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-24 09:22:08.290737) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-24 09:22:08.294085) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-24 09:22:08.310990) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 09:22:08.311288) ========= 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.z5r4gQeHn3/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.n8ooadwoVf/Listeners TMPDIR=/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/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.005319 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 09:22:08.359483) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-24 09:22:08.362720) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-24 09:22:08.363109) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 09:22:08.363389) ========= 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.z5r4gQeHn3/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.n8ooadwoVf/Listeners TMPDIR=/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-02-24 09:22:08-- 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% 8.45M=0.001s 2016-02-24 09:22:08 (8.45 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101166 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 09:22:08.479582) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 09:22:08.479901) ========= 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.z5r4gQeHn3/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.n8ooadwoVf/Listeners TMPDIR=/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/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.019230 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 09:22:08.527941) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-02-24 09:22:08.528285) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 254c6ce06541ff04ed083dbc58623a4a2cebb110 --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 254c6ce06541ff04ed083dbc58623a4a2cebb110 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.z5r4gQeHn3/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.n8ooadwoVf/Listeners TMPDIR=/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-02-24 09:22:08,606 truncating revision to first 12 chars 2016-02-24 09:22:08,607 Setting DEBUG logging. 2016-02-24 09:22:08,607 attempt 1/10 2016-02-24 09:22:08,607 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/254c6ce06541?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-24 09:22:09,822 unpacking tar archive at: fx-team-254c6ce06541/testing/mozharness/ program finished with exit code 0 elapsedTime=1.463226 ========= master_lag: 1.58 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-02-24 09:22:11.572794) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-24 09:22:11.573139) ========= echo 254c6ce06541ff04ed083dbc58623a4a2cebb110 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'254c6ce06541ff04ed083dbc58623a4a2cebb110'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.z5r4gQeHn3/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.n8ooadwoVf/Listeners TMPDIR=/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/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 254c6ce06541ff04ed083dbc58623a4a2cebb110 program finished with exit code 0 elapsedTime=0.004901 script_repo_revision: '254c6ce06541ff04ed083dbc58623a4a2cebb110' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-24 09:22:11.627443) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 3 secs) (at 2016-02-24 09:22:11.627797) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 3 secs) (at 2016-02-24 09:22:15.352572) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-02-24 09:22:15.352886) ========= /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.z5r4gQeHn3/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.n8ooadwoVf/Listeners TMPDIR=/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/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 09:22:15 INFO - MultiFileLogger online at 20160224 09:22:15 in /builds/slave/test 09:22:15 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 09:22:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:22:15 INFO - {'append_to_log': False, 09:22:15 INFO - 'base_work_dir': '/builds/slave/test', 09:22:15 INFO - 'blob_upload_branch': 'Fx-Team', 09:22:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:22:15 INFO - 'branch': 'Fx-Team', 09:22:15 INFO - 'buildbot_json_path': 'buildprops.json', 09:22:15 INFO - 'config_files': ('talos/mac_config.py',), 09:22:15 INFO - 'default_actions': ('clobber', 09:22:15 INFO - 'read-buildbot-config', 09:22:15 INFO - 'download-and-extract', 09:22:15 INFO - 'populate-webroot', 09:22:15 INFO - 'create-virtualenv', 09:22:15 INFO - 'install', 09:22:15 INFO - 'run-tests'), 09:22:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:22:15 INFO - 'download_minidump_stackwalk': True, 09:22:15 INFO - 'download_symbols': 'ondemand', 09:22:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:22:15 INFO - 'tooltool.py': '/tools/tooltool.py', 09:22:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:22:15 INFO - '/tools/misc-python/virtualenv.py')}, 09:22:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:22:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:22:15 INFO - 'installer_path': 'installer.exe', 09:22:15 INFO - 'log_level': 'info', 09:22:15 INFO - 'log_name': 'talos', 09:22:15 INFO - 'log_to_console': True, 09:22:15 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:22:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:22:15 INFO - 'opt_config_files': (), 09:22:15 INFO - 'pip_index': False, 09:22:15 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:22:15 INFO - 'cmd': ('bash', 09:22:15 INFO - '-c', 09:22:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:22:15 INFO - 'enabled': True, 09:22:15 INFO - 'halt_on_failure': False, 09:22:15 INFO - 'name': 'check_screen_resolution'},), 09:22:15 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:22:15 INFO - 'cmd': ('bash', 09:22:15 INFO - '-c', 09:22:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:22:15 INFO - 'enabled': True, 09:22:15 INFO - 'halt_on_failure': False, 09:22:15 INFO - 'name': 'check_screen_resolution'},), 09:22:15 INFO - 'run_cmd_checks_enabled': True, 09:22:15 INFO - 'sps_profile': False, 09:22:15 INFO - 'sps_profile_interval': 0, 09:22:15 INFO - 'suite': 'dromaeojs', 09:22:15 INFO - 'system_bits': '32', 09:22:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:22:15 INFO - 'title': 't-yosemite-r7-0168', 09:22:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:22:15 INFO - 'use_talos_json': True, 09:22:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:22:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:22:15 INFO - 'work_dir': 'build'} 09:22:15 INFO - ##### 09:22:15 INFO - ##### Running clobber step. 09:22:15 INFO - ##### 09:22:15 INFO - Running pre-action listener: _resource_record_pre_action 09:22:15 INFO - Running main action method: clobber 09:22:15 INFO - rmtree: /builds/slave/test/build 09:22:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:22:16 INFO - Running post-action listener: _resource_record_post_action 09:22:16 INFO - ##### 09:22:16 INFO - ##### Running read-buildbot-config step. 09:22:16 INFO - ##### 09:22:16 INFO - Running pre-action listener: _resource_record_pre_action 09:22:16 INFO - Running main action method: read_buildbot_config 09:22:16 INFO - Using buildbot properties: 09:22:16 INFO - { 09:22:16 INFO - "project": "", 09:22:16 INFO - "product": "firefox", 09:22:16 INFO - "script_repo_revision": "production", 09:22:16 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 09:22:16 INFO - "repository": "", 09:22:16 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 09:22:16 INFO - "buildid": "20160224082844", 09:22:16 INFO - "pgo_build": "False", 09:22:16 INFO - "basedir": "/builds/slave/test", 09:22:16 INFO - "buildnumber": 431, 09:22:16 INFO - "slavename": "t-yosemite-r7-0168", 09:22:16 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 09:22:16 INFO - "platform": "yosemite_r7", 09:22:16 INFO - "scheduler": "tests-fx-team-macosx64-talos", 09:22:16 INFO - "branch": "fx-team", 09:22:16 INFO - "repo_path": "integration/fx-team", 09:22:16 INFO - "revision": "254c6ce06541ff04ed083dbc58623a4a2cebb110", 09:22:16 INFO - "stage_platform": "macosx64", 09:22:16 INFO - "builduid": "b35ed84b2eda4fcb882520d41f72eab5", 09:22:16 INFO - "slavebuilddir": "test" 09:22:16 INFO - } 09:22:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 09:22:16 INFO - Running post-action listener: _resource_record_post_action 09:22:16 INFO - ##### 09:22:16 INFO - ##### Running download-and-extract step. 09:22:16 INFO - ##### 09:22:16 INFO - Running pre-action listener: _resource_record_pre_action 09:22:16 INFO - Running main action method: download_and_extract 09:22:16 INFO - mkdir: /builds/slave/test/build/tests 09:22:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:22:16 INFO - https://queue.taskcluster.net/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:22:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/test_packages.json 09:22:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/test_packages.json 09:22:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 09:22:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 09:22:17 INFO - Downloaded 1277 bytes. 09:22:17 INFO - Reading from file /builds/slave/test/build/test_packages.json 09:22:17 INFO - Using the following test package requirements: 09:22:17 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 09:22:17 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:22:17 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 09:22:17 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:22:17 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 09:22:17 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:22:17 INFO - u'jsshell-mac.zip'], 09:22:17 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:22:17 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 09:22:17 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 09:22:17 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:22:17 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 09:22:17 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:22:17 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 09:22:17 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:22:17 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 09:22:17 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 09:22:17 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:22:17 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 09:22:17 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:22:17 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')]} 09:22:17 INFO - https://queue.taskcluster.net/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:22:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 09:22:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 09:22:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 09:22:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:22:18 INFO - Downloaded 17827707 bytes. 09:22:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:22:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:22:21 INFO - Return code: 0 09:22:21 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 09:22:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:22:21 INFO - https://queue.taskcluster.net/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:22:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 09:22:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 09:22:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 09:22:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:22:22 INFO - Downloaded 17827707 bytes. 09:22:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:22:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:22:26 INFO - Return code: 0 09:22:26 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')]} 09:22:26 INFO - https://queue.taskcluster.net/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:22:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 09:22:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 09:22:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 09:22:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:22:27 INFO - Downloaded 10707015 bytes. 09:22:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:22:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 09:22:28 INFO - Return code: 0 09:22:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:22:28 INFO - https://queue.taskcluster.net/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 09:22:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 09:22:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 09:22:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 09:22:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 09:22:34 INFO - Downloaded 111441828 bytes. 09:22:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 09:22:34 INFO - mkdir: /builds/slave/test/properties 09:22:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:22:34 INFO - Writing to file /builds/slave/test/properties/build_url 09:22:34 INFO - Contents: 09:22:34 INFO - build_url:https://queue.taskcluster.net/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 09:22:36 INFO - Running post-action listener: _resource_record_post_action 09:22:36 INFO - Running post-action listener: set_extra_try_arguments 09:22:36 INFO - ##### 09:22:36 INFO - ##### Running populate-webroot step. 09:22:36 INFO - ##### 09:22:36 INFO - Running pre-action listener: _resource_record_pre_action 09:22:36 INFO - Running main action method: populate_webroot 09:22:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:22:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:22:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:22:36 INFO - '--tppagecycles', 09:22:36 INFO - '7'], 09:22:36 INFO - 'tests': ['tsvgm']}}, 09:22:36 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:22:36 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:22:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:22:36 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:22:36 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:22:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:22:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:22:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:22:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:22:36 INFO - 'talos_options': ['--e10s'], 09:22:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:22:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:22:36 INFO - 'tests': ['damp', 'tps']}, 09:22:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:22:36 INFO - 'talos_options': ['--e10s'], 09:22:36 INFO - 'tests': ['damp', 'tps']}, 09:22:36 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:22:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:22:36 INFO - 'other': {'tests': ['a11yr', 09:22:36 INFO - 'ts_paint', 09:22:36 INFO - 'tpaint', 09:22:36 INFO - 'sessionrestore', 09:22:36 INFO - 'sessionrestore_no_auto_restore']}, 09:22:36 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:22:36 INFO - 'tests': ['a11yr', 09:22:36 INFO - 'ts_paint', 09:22:36 INFO - 'tpaint', 09:22:36 INFO - 'sessionrestore', 09:22:36 INFO - 'sessionrestore_no_auto_restore']}, 09:22:36 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:22:36 INFO - 'tests': ['a11yr', 09:22:36 INFO - 'ts_paint', 09:22:36 INFO - 'tpaint', 09:22:36 INFO - 'sessionrestore', 09:22:36 INFO - 'sessionrestore_no_auto_restore']}, 09:22:36 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:22:36 INFO - 'tests': ['a11yr', 09:22:36 INFO - 'ts_paint', 09:22:36 INFO - 'tpaint', 09:22:36 INFO - 'sessionrestore', 09:22:36 INFO - 'sessionrestore_no_auto_restore']}, 09:22:36 INFO - 'other_l64': {'tests': ['a11yr', 09:22:36 INFO - 'ts_paint', 09:22:36 INFO - 'tpaint', 09:22:36 INFO - 'sessionrestore', 09:22:36 INFO - 'sessionrestore_no_auto_restore']}, 09:22:36 INFO - 'other_nol64': {'tests': ['a11yr', 09:22:36 INFO - 'ts_paint', 09:22:36 INFO - 'tpaint', 09:22:36 INFO - 'sessionrestore', 09:22:36 INFO - 'sessionrestore_no_auto_restore']}, 09:22:36 INFO - 'svgr': {'tests': ['tsvgx', 09:22:36 INFO - 'tsvgr_opacity', 09:22:36 INFO - 'tart', 09:22:36 INFO - 'tscrollx', 09:22:36 INFO - 'cart']}, 09:22:36 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:22:36 INFO - 'tests': ['tsvgx', 09:22:36 INFO - 'tsvgr_opacity', 09:22:36 INFO - 'tart', 09:22:36 INFO - 'tscrollx', 09:22:36 INFO - 'cart']}, 09:22:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:22:36 INFO - 'tests': ['tp5o']}, 09:22:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:22:36 INFO - 'talos_options': ['--e10s'], 09:22:36 INFO - 'tests': ['tp5o']}, 09:22:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:22:36 INFO - 'talos_options': ['--xperf_path', 09:22:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:22:36 INFO - 'tests': ['tp5n']}, 09:22:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:22:36 INFO - 'talos_options': ['--e10s', 09:22:36 INFO - '--xperf_path', 09:22:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:22:36 INFO - 'tests': ['tp5n']}}, 09:22:36 INFO - 'talos.zip': {'path': '', 09:22:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:22:36 INFO - Running post-action listener: _resource_record_post_action 09:22:36 INFO - ##### 09:22:36 INFO - ##### Running create-virtualenv step. 09:22:36 INFO - ##### 09:22:36 INFO - Running pre-action listener: _resource_record_pre_action 09:22:36 INFO - Running main action method: create_virtualenv 09:22:36 INFO - Creating virtualenv /builds/slave/test/build/venv 09:22:36 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 09:22:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:22:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:22:36 INFO - Using real prefix '/tools/python27' 09:22:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:22:36 INFO - Installing distribute.............................................................................................................................................................................................done. 09:22:39 INFO - Installing pip.................done. 09:22:39 INFO - Return code: 0 09:22:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:22: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')]} 09:22:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22: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')]} 09:22:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:39 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 0x10cf2aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf324c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd803db62e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdced30>, '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 0x10cbf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cdc5b20>, '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.z5r4gQeHn3/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.n8ooadwoVf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/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 09:22:39 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 09:22:39 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 09:22:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z5r4gQeHn3/Render', 09:22:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:22:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:22:39 INFO - 'HOME': '/Users/cltbld', 09:22:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:22:39 INFO - 'LOGNAME': 'cltbld', 09:22:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:39 INFO - 'MOZ_NO_REMOTE': '1', 09:22:39 INFO - 'NO_EM_RESTART': '1', 09:22:39 INFO - 'PAGER': '/bin/cat', 09:22:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:22:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:39 INFO - 'PWD': '/builds/slave/test', 09:22:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:22:39 INFO - 'SHELL': '/bin/bash', 09:22:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n8ooadwoVf/Listeners', 09:22:39 INFO - 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/', 09:22:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:22:39 INFO - 'USER': 'cltbld', 09:22:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:22:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:22:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:39 INFO - 'XPC_FLAGS': '0x0', 09:22:39 INFO - 'XPC_SERVICE_NAME': '0', 09:22:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:22:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:39 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 09:22:39 INFO - Cleaning up... 09:22:40 INFO - Return code: 0 09:22:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:22:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:22:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:22:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:40 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 0x10cf2aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf324c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd803db62e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdced30>, '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 0x10cbf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cdc5b20>, '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.z5r4gQeHn3/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.n8ooadwoVf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/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 09:22:40 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 09:22:40 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 09:22:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z5r4gQeHn3/Render', 09:22:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:22:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:22:40 INFO - 'HOME': '/Users/cltbld', 09:22:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:22:40 INFO - 'LOGNAME': 'cltbld', 09:22:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:40 INFO - 'MOZ_NO_REMOTE': '1', 09:22:40 INFO - 'NO_EM_RESTART': '1', 09:22:40 INFO - 'PAGER': '/bin/cat', 09:22:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:22:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:40 INFO - 'PWD': '/builds/slave/test', 09:22:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:22:40 INFO - 'SHELL': '/bin/bash', 09:22:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n8ooadwoVf/Listeners', 09:22:40 INFO - 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/', 09:22:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:22:40 INFO - 'USER': 'cltbld', 09:22:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:22:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:22:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:40 INFO - 'XPC_FLAGS': '0x0', 09:22:40 INFO - 'XPC_SERVICE_NAME': '0', 09:22:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:22:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:40 INFO - Downloading/unpacking psutil>=0.7.1 09:22:40 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 09:22:40 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 09:22:40 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 09:22:40 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 09:22:40 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 09:22:40 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 09:22:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:22:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:22:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:22:42 INFO - Installing collected packages: psutil 09:22:42 INFO - Running setup.py install for psutil 09:22:42 INFO - building 'psutil._psutil_osx' extension 09:22:42 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 09:22:43 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 09:22:43 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 09:22:43 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 09:22:43 INFO - building 'psutil._psutil_posix' extension 09:22:43 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 09:22:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:22:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:22:43 INFO - ^ 09:22:43 INFO - 1 warning generated. 09:22:43 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 09:22:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:22:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:22:43 INFO - Successfully installed psutil 09:22:43 INFO - Cleaning up... 09:22:43 INFO - Return code: 0 09:22:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:22: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')]} 09:22:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22: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')]} 09:22:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:43 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 0x10cf2aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf324c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd803db62e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdced30>, '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 0x10cbf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cdc5b20>, '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.z5r4gQeHn3/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.n8ooadwoVf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/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 09:22:43 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 09:22:43 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 09:22:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z5r4gQeHn3/Render', 09:22:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:22:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:22:43 INFO - 'HOME': '/Users/cltbld', 09:22:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:22:43 INFO - 'LOGNAME': 'cltbld', 09:22:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:43 INFO - 'MOZ_NO_REMOTE': '1', 09:22:43 INFO - 'NO_EM_RESTART': '1', 09:22:43 INFO - 'PAGER': '/bin/cat', 09:22:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:22:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:43 INFO - 'PWD': '/builds/slave/test', 09:22:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:22:43 INFO - 'SHELL': '/bin/bash', 09:22:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n8ooadwoVf/Listeners', 09:22:43 INFO - 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/', 09:22:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:22:43 INFO - 'USER': 'cltbld', 09:22:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:22:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:22:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:43 INFO - 'XPC_FLAGS': '0x0', 09:22:43 INFO - 'XPC_SERVICE_NAME': '0', 09:22:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:22:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:22:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:22:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:22:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:22:46 INFO - Installing collected packages: mozsystemmonitor 09:22:46 INFO - Running setup.py install for mozsystemmonitor 09:22:46 INFO - Successfully installed mozsystemmonitor 09:22:46 INFO - Cleaning up... 09:22:46 INFO - Return code: 0 09:22:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:22:46 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')]} 09:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:46 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')]} 09:22:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:46 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 0x10cf2aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf324c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd803db62e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdced30>, '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 0x10cbf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cdc5b20>, '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.z5r4gQeHn3/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.n8ooadwoVf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/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 09:22:46 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 09:22:46 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 09:22:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z5r4gQeHn3/Render', 09:22:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:22:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:22:46 INFO - 'HOME': '/Users/cltbld', 09:22:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:22:46 INFO - 'LOGNAME': 'cltbld', 09:22:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:46 INFO - 'MOZ_NO_REMOTE': '1', 09:22:46 INFO - 'NO_EM_RESTART': '1', 09:22:46 INFO - 'PAGER': '/bin/cat', 09:22:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:22:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:46 INFO - 'PWD': '/builds/slave/test', 09:22:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:22:46 INFO - 'SHELL': '/bin/bash', 09:22:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n8ooadwoVf/Listeners', 09:22:46 INFO - 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/', 09:22:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:22:46 INFO - 'USER': 'cltbld', 09:22:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:22:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:22:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:46 INFO - 'XPC_FLAGS': '0x0', 09:22:46 INFO - 'XPC_SERVICE_NAME': '0', 09:22:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:22:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:46 INFO - Downloading/unpacking blobuploader==1.2.4 09:22:46 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 09:22:46 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 09:22:46 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 09:22:46 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 09:22:46 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 09:22:46 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 09:22:49 INFO - Downloading blobuploader-1.2.4.tar.gz 09:22:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:22:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:22:49 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 09:22:49 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 09:22:49 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 09:22:49 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 09:22:49 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 09:22:49 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 09:22:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:22:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:22:49 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 09:22:49 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 09:22:49 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 09:22:49 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 09:22:49 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 09:22:49 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 09:22:50 INFO - Downloading docopt-0.6.1.tar.gz 09:22:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:22:50 INFO - Installing collected packages: blobuploader, requests, docopt 09:22:50 INFO - Running setup.py install for blobuploader 09:22:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:22:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:22:50 INFO - Running setup.py install for requests 09:22:51 INFO - Running setup.py install for docopt 09:22:51 INFO - Successfully installed blobuploader requests docopt 09:22:51 INFO - Cleaning up... 09:22:51 INFO - Return code: 0 09:22:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:22:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:22:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:22:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:51 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 0x10cf2aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf324c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd803db62e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdced30>, '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 0x10cbf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cdc5b20>, '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.z5r4gQeHn3/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.n8ooadwoVf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/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 09:22:51 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 09:22:51 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 09:22:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z5r4gQeHn3/Render', 09:22:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:22:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:22:51 INFO - 'HOME': '/Users/cltbld', 09:22:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:22:51 INFO - 'LOGNAME': 'cltbld', 09:22:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:51 INFO - 'MOZ_NO_REMOTE': '1', 09:22:51 INFO - 'NO_EM_RESTART': '1', 09:22:51 INFO - 'PAGER': '/bin/cat', 09:22:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:22:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:51 INFO - 'PWD': '/builds/slave/test', 09:22:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:22:51 INFO - 'SHELL': '/bin/bash', 09:22:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n8ooadwoVf/Listeners', 09:22:51 INFO - 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/', 09:22:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:22:51 INFO - 'USER': 'cltbld', 09:22:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:22:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:22:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:51 INFO - 'XPC_FLAGS': '0x0', 09:22:51 INFO - 'XPC_SERVICE_NAME': '0', 09:22:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:22:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:22:51 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-IhZgCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:22:51 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-RNgbf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:22:51 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-W6Btfa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:22:51 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-PKvqlR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:22:51 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-8jA8AA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:22:52 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-FAAGtR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:22:52 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-xutAr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:22:52 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-A2DMgN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:22:52 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-25zMSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:22:52 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-mX2K5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:22:52 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-DYerXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:22:52 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-LsXsm3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:22:52 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-eckncn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:22:52 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-jeXUou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:22:52 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-GI4_T0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:22:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:22:53 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-snHRt1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:22:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:22:53 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-Spv0E1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:22:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:22:53 INFO - Running setup.py install for manifestparser 09:22:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:22:53 INFO - Running setup.py install for mozcrash 09:22:53 INFO - Running setup.py install for mozdebug 09:22:53 INFO - Running setup.py install for mozdevice 09:22:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:22:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:22:53 INFO - Running setup.py install for mozfile 09:22:54 INFO - Running setup.py install for mozhttpd 09:22:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:22:54 INFO - Running setup.py install for mozinfo 09:22:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:22:54 INFO - Running setup.py install for mozInstall 09:22:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:22:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:22:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:22:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:22:54 INFO - Running setup.py install for mozleak 09:22:54 INFO - Running setup.py install for mozlog 09:22:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:22:54 INFO - Running setup.py install for moznetwork 09:22:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:22:54 INFO - Running setup.py install for mozprocess 09:22:55 INFO - Running setup.py install for mozprofile 09:22:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:22:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:22:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:22:55 INFO - Running setup.py install for mozrunner 09:22:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:22:55 INFO - Running setup.py install for mozscreenshot 09:22:55 INFO - Running setup.py install for moztest 09:22:55 INFO - Running setup.py install for mozversion 09:22:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:22:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:22:55 INFO - Cleaning up... 09:22:55 INFO - Return code: 0 09:22:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:22:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:22:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:55 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 0x10cf2aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf324c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd803db62e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdced30>, '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 0x10cbf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cdc5b20>, '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.z5r4gQeHn3/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.n8ooadwoVf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/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 09:22:55 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 09:22:55 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 09:22:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z5r4gQeHn3/Render', 09:22:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:22:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:22:55 INFO - 'HOME': '/Users/cltbld', 09:22:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:22:55 INFO - 'LOGNAME': 'cltbld', 09:22:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:55 INFO - 'MOZ_NO_REMOTE': '1', 09:22:55 INFO - 'NO_EM_RESTART': '1', 09:22:55 INFO - 'PAGER': '/bin/cat', 09:22:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:22:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:55 INFO - 'PWD': '/builds/slave/test', 09:22:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:22:55 INFO - 'SHELL': '/bin/bash', 09:22:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n8ooadwoVf/Listeners', 09:22:55 INFO - 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/', 09:22:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:22:55 INFO - 'USER': 'cltbld', 09:22:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:22:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:22:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:55 INFO - 'XPC_FLAGS': '0x0', 09:22:55 INFO - 'XPC_SERVICE_NAME': '0', 09:22:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:22:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:22:56 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-ub4QgL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:22:56 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)) 09:22:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:22:56 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-TjUh4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:22:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:22:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:22:56 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-IOkK3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:22:56 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)) 09:22:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:22:56 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-hKmr09-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:22:56 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)) 09:22:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:22:56 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-Lj_Jfe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:22:56 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)) 09:22:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:22:56 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-dwA8FF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:22:56 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)) 09:22:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:22:56 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-TCkRvj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:22:56 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)) 09:22:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:22:56 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-5OuwsY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:22:56 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)) 09:22:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:22:56 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-XVFGod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:22:57 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)) 09:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:22:57 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-2JRG_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:22:57 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)) 09:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:22:57 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-u1nPXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:22:57 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)) 09:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:22:57 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-UWFIqp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:22:57 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)) 09:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:22:57 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-DWilCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:22:57 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)) 09:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:22:57 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-NpnZ56-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:22:57 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)) 09:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:22:57 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-ZoAOJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:22:57 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)) 09:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:22:57 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-x6kY9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:22:57 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)) 09:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:22:57 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-i3lLjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:22:57 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)) 09:22:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:22:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:22:57 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)) 09:22:57 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)) 09:22:57 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)) 09:22:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:22:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:00 INFO - Downloading blessings-1.6.tar.gz 09:23:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:23:00 INFO - Installing collected packages: blessings 09:23:00 INFO - Running setup.py install for blessings 09:23:00 INFO - Successfully installed blessings 09:23:00 INFO - Cleaning up... 09:23:00 INFO - Return code: 0 09:23:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:23:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:23:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:23:00 INFO - Reading from file tmpfile_stdout 09:23:00 INFO - Current package versions: 09:23:00 INFO - blessings == 1.6 09:23:00 INFO - blobuploader == 1.2.4 09:23:00 INFO - docopt == 0.6.1 09:23:00 INFO - manifestparser == 1.1 09:23:00 INFO - mozInstall == 1.12 09:23:00 INFO - mozcrash == 0.16 09:23:00 INFO - mozdebug == 0.1 09:23:00 INFO - mozdevice == 0.48 09:23:00 INFO - mozfile == 1.2 09:23:00 INFO - mozhttpd == 0.7 09:23:00 INFO - mozinfo == 0.9 09:23:00 INFO - mozleak == 0.1 09:23:00 INFO - mozlog == 3.1 09:23:00 INFO - moznetwork == 0.27 09:23:00 INFO - mozprocess == 0.22 09:23:00 INFO - mozprofile == 0.28 09:23:00 INFO - mozrunner == 6.11 09:23:00 INFO - mozscreenshot == 0.1 09:23:00 INFO - mozsystemmonitor == 0.0 09:23:00 INFO - moztest == 0.7 09:23:00 INFO - mozversion == 1.4 09:23:00 INFO - psutil == 3.1.1 09:23:00 INFO - requests == 1.2.3 09:23:00 INFO - wsgiref == 0.1.2 09:23:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:23:00 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')]} 09:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:00 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')]} 09:23:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:00 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 0x10cf2aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf324c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd803db62e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdced30>, '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 0x10cbf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cdc5b20>, '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.z5r4gQeHn3/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.n8ooadwoVf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/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 09:23:00 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 09:23:00 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 09:23:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z5r4gQeHn3/Render', 09:23:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:23:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:23:00 INFO - 'HOME': '/Users/cltbld', 09:23:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:23:00 INFO - 'LOGNAME': 'cltbld', 09:23:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:00 INFO - 'MOZ_NO_REMOTE': '1', 09:23:00 INFO - 'NO_EM_RESTART': '1', 09:23:00 INFO - 'PAGER': '/bin/cat', 09:23:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:23:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:00 INFO - 'PWD': '/builds/slave/test', 09:23:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:23:00 INFO - 'SHELL': '/bin/bash', 09:23:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n8ooadwoVf/Listeners', 09:23:00 INFO - 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/', 09:23:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:23:00 INFO - 'USER': 'cltbld', 09:23:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:23:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:23:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:00 INFO - 'XPC_FLAGS': '0x0', 09:23:00 INFO - 'XPC_SERVICE_NAME': '0', 09:23:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:23:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:01 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)) 09:23:01 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)) 09:23:01 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)) 09:23:01 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)) 09:23:01 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)) 09:23:01 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)) 09:23:01 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)) 09:23:01 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)) 09:23:01 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)) 09:23:01 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)) 09:23:01 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)) 09:23:01 INFO - Cleaning up... 09:23:01 INFO - Return code: 0 09:23:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:23: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')]} 09:23:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23: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')]} 09:23:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cf2aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf324c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd803db62e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdced30>, '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 0x10cbf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cdc5b20>, '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.z5r4gQeHn3/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.n8ooadwoVf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/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 09:23: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', 'jsonschema'] in /builds/slave/test/build 09:23: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 jsonschema 09:23:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z5r4gQeHn3/Render', 09:23:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:23:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:23:01 INFO - 'HOME': '/Users/cltbld', 09:23:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:23:01 INFO - 'LOGNAME': 'cltbld', 09:23:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:01 INFO - 'MOZ_NO_REMOTE': '1', 09:23:01 INFO - 'NO_EM_RESTART': '1', 09:23:01 INFO - 'PAGER': '/bin/cat', 09:23:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:23:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:01 INFO - 'PWD': '/builds/slave/test', 09:23:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:23:01 INFO - 'SHELL': '/bin/bash', 09:23:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n8ooadwoVf/Listeners', 09:23:01 INFO - 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/', 09:23:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:23:01 INFO - 'USER': 'cltbld', 09:23:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:23:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:23:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:01 INFO - 'XPC_FLAGS': '0x0', 09:23:01 INFO - 'XPC_SERVICE_NAME': '0', 09:23:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:23:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:01 INFO - Downloading/unpacking jsonschema 09:23: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 09:23: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 09:23: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 09:23: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 09:23: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 09:23: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 09:23:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:23:03 INFO - Downloading/unpacking functools32 (from jsonschema) 09:23:03 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 09:23:03 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 09:23:03 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 09:23:03 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 09:23:03 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 09:23:03 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 09:23:04 INFO - Downloading functools32-3.2.3-2.tar.gz 09:23:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:23:04 INFO - warning: no files found matching '*.txt' 09:23:04 INFO - no previously-included directories found matching 'build' 09:23:04 INFO - no previously-included directories found matching 'dist' 09:23:04 INFO - no previously-included directories found matching '.git*' 09:23:04 INFO - Installing collected packages: jsonschema, functools32 09:23:04 INFO - Running setup.py install for functools32 09:23:04 INFO - warning: no files found matching '*.txt' 09:23:04 INFO - no previously-included directories found matching 'build' 09:23:04 INFO - no previously-included directories found matching 'dist' 09:23:04 INFO - no previously-included directories found matching '.git*' 09:23:04 INFO - Successfully installed jsonschema functools32 09:23:04 INFO - Cleaning up... 09:23:04 INFO - Return code: 0 09:23:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:23:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cf2aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf324c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd803db62e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdced30>, '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 0x10cbf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cdc5b20>, '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.z5r4gQeHn3/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.n8ooadwoVf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/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 09:23:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 09:23:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:23:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z5r4gQeHn3/Render', 09:23:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:23:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:23:04 INFO - 'HOME': '/Users/cltbld', 09:23:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:23:04 INFO - 'LOGNAME': 'cltbld', 09:23:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:04 INFO - 'MOZ_NO_REMOTE': '1', 09:23:04 INFO - 'NO_EM_RESTART': '1', 09:23:04 INFO - 'PAGER': '/bin/cat', 09:23:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:23:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:04 INFO - 'PWD': '/builds/slave/test', 09:23:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:23:04 INFO - 'SHELL': '/bin/bash', 09:23:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n8ooadwoVf/Listeners', 09:23:04 INFO - 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/', 09:23:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:23:04 INFO - 'USER': 'cltbld', 09:23:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:23:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:23:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:04 INFO - 'XPC_FLAGS': '0x0', 09:23:04 INFO - 'XPC_SERVICE_NAME': '0', 09:23:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:23:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:04 INFO - Downloading/unpacking flake8 09:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:23:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:23:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:23:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:23:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:23:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:23:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:23:08 INFO - no previously-included directories found matching 'docs/_build' 09:23:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:23:08 INFO - Running setup.py install for pep8 09:23:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:23:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:23:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:23:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:23:08 INFO - no previously-included directories found matching 'docs/_build' 09:23:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:23:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:23:08 INFO - Cleaning up... 09:23:08 INFO - Return code: 0 09:23:08 INFO - Running post-action listener: _resource_record_post_action 09:23:08 INFO - Running post-action listener: _start_resource_monitoring 09:23:08 INFO - Starting resource monitoring. 09:23:08 INFO - ##### 09:23:08 INFO - ##### Running install step. 09:23:08 INFO - ##### 09:23:08 INFO - Running pre-action listener: _resource_record_pre_action 09:23:08 INFO - Running main action method: install 09:23:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:23:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:23:09 INFO - Reading from file tmpfile_stdout 09:23:09 INFO - Detecting whether we're running mozinstall >=1.0... 09:23:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:23:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:23:09 INFO - Reading from file tmpfile_stdout 09:23:09 INFO - Output received: 09:23:09 INFO - Usage: mozinstall [options] installer 09:23:09 INFO - Options: 09:23:09 INFO - -h, --help show this help message and exit 09:23:09 INFO - -d DEST, --destination=DEST 09:23:09 INFO - Directory to install application into. [default: 09:23:09 INFO - "/builds/slave/test"] 09:23:09 INFO - --app=APP Application being installed. [default: firefox] 09:23:09 INFO - mkdir: /builds/slave/test/build/application 09:23:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:23:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 09:23:42 INFO - Reading from file tmpfile_stdout 09:23:42 INFO - Output received: 09:23:42 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:23:42 INFO - Running post-action listener: _resource_record_post_action 09:23:42 INFO - ##### 09:23:42 INFO - ##### Running run-tests step. 09:23:42 INFO - ##### 09:23:42 INFO - Running pre-action listener: _resource_record_pre_action 09:23:42 INFO - Running main action method: run_tests 09:23:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:23:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:23:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:23:42 INFO - 2016-02-24 09:23:42.982 screenresolution[1969:11756] starting screenresolution argv=screenresolution get 09:23:42 INFO - 2016-02-24 09:23:42.985 screenresolution[1969:11756] Display 0: 1600x1200x32@60 09:23:42 INFO - 2016-02-24 09:23:42.991 screenresolution[1970:11758] starting screenresolution argv=screenresolution list 09:23:42 INFO - Available Modes on Display 0 09:23:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:23:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:23:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:23:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:23:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:23:43 INFO - Intel Iris: 09:23:43 INFO - Chipset Model: Intel Iris 09:23:43 INFO - Type: GPU 09:23:43 INFO - Bus: Built-In 09:23:43 INFO - VRAM (Dynamic, Max): 1536 MB 09:23:43 INFO - Vendor: Intel (0x8086) 09:23:43 INFO - Device ID: 0x0a2e 09:23:43 INFO - Revision ID: 0x0009 09:23:43 INFO - Displays: 09:23:43 INFO - Display: 09:23:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:23:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:23:43 INFO - Display Serial Number: 1600x1200 60 09:23:43 INFO - Main Display: Yes 09:23:43 INFO - Mirror: Off 09:23:43 INFO - Online: Yes 09:23:43 INFO - Rotation: Supported 09:23:43 INFO - Return code: 0 09:23:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:23:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:23:43 INFO - Python 2.7.3 09:23:43 INFO - Return code: 0 09:23:43 INFO - grabbing minidump binary from tooltool 09:23: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')]} 09:23:43 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 0x10cdced30>, '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 0x10cbf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cdc5b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:23:43 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 09:23:43 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 09:23:43 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:23:43 INFO - Return code: 0 09:23:43 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:23:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:23:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:23:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:23:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:23:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:23:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:23:44 INFO - Return code: 0 09:23:44 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/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0168', '--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 09:23:44 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/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0168 --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 09:23:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z5r4gQeHn3/Render', 09:23:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:23:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:23:44 INFO - 'HOME': '/Users/cltbld', 09:23:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:23:44 INFO - 'LOGNAME': 'cltbld', 09:23:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:23:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:23:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:44 INFO - 'MOZ_NO_REMOTE': '1', 09:23:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:23:44 INFO - 'NO_EM_RESTART': '1', 09:23:44 INFO - 'PAGER': '/bin/cat', 09:23:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:23:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:44 INFO - 'PWD': '/builds/slave/test', 09:23:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:23:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:23:44 INFO - 'SHELL': '/bin/bash', 09:23:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n8ooadwoVf/Listeners', 09:23:44 INFO - 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/', 09:23:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:23:44 INFO - 'USER': 'cltbld', 09:23:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:23:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:23:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:44 INFO - 'XPC_FLAGS': '0x0', 09:23:44 INFO - 'XPC_SERVICE_NAME': '0', 09:23:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:23:44 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/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0168', '--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 09:23:44 INFO - mozversion application_buildid: 20160224082844 09:23:44 INFO - mozversion application_changeset: 254c6ce06541ff04ed083dbc58623a4a2cebb110 09:23:44 INFO - mozversion application_display_name: Nightly 09:23:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:23:44 INFO - mozversion application_name: Firefox 09:23:44 INFO - mozversion application_remotingname: firefox 09:23:44 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:23:44 INFO - mozversion application_vendor: Mozilla 09:23:44 INFO - mozversion application_version: 47.0a1 09:23:44 INFO - mozversion platform_buildid: 20160224082844 09:23:44 INFO - mozversion platform_changeset: 254c6ce06541ff04ed083dbc58623a4a2cebb110 09:23:44 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:23:44 INFO - mozversion platform_version: 47.0a1 09:23:44 INFO - using testdate: 1456334624 09:23:44 INFO - actual date: 1456334624 09:23:45 INFO - starting webserver on 'localhost:49739' 09:23:45 INFO - SUITE-START | Running 2 tests 09:23:45 INFO - TEST-START | dromaeo_css 09:23:45 INFO - operating with platform_type : mac_ 09:23:45 INFO - Initialising browser for dromaeo_css test... 09:23:45 INFO - TEST-INFO | started process 1988 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/tmpSuuc5H/profile http://localhost:49739/getInfo.html) 09:23:47 INFO - PROCESS | 1988 | __metrics Screen width/height:1600/1200 09:23:47 INFO - PROCESS | 1988 | colorDepth:24 09:23:47 INFO - PROCESS | 1988 | Browser inner width/height: 1024/689 09:23:47 INFO - PROCESS | 1988 | __metrics 09:23:47 INFO - PROCESS | 1988 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:23:47 INFO - PROCESS | 1988 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:23:48 INFO - TEST-INFO | 1988: exit 0 09:23:48 INFO - Browser initialized. 09:23:48 INFO - Running cycle 1/1 for dromaeo_css test... 09:23:48 INFO - TEST-INFO | started process 1991 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/tmpSuuc5H/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:23:59 INFO - PROCESS | 1991 | RSS: Main: 242991104 09:23:59 INFO - PROCESS | 1991 | 09:24:51 INFO - PROCESS | 1991 | 1456334690999 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] 09:27:02 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:49739/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49739/tests/dromaeo/cssquery-ext.html) 09:27:03 INFO - PROCESS | 1991 | RSS: Main: 339865600 09:27:03 INFO - PROCESS | 1991 | 09:30:05 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:49739/tests/dromaeo/cssquery-ext.html (next: http://localhost:49739/tests/dromaeo/cssquery-jquery.html) 09:30:06 INFO - PROCESS | 1991 | RSS: Main: 377888768 09:30:06 INFO - PROCESS | 1991 | 09:33:08 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:49739/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49739/tests/dromaeo/cssquery-mootools.html) 09:33:09 INFO - PROCESS | 1991 | RSS: Main: 375517184 09:33:09 INFO - PROCESS | 1991 | 09:36:11 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:49739/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49739/tests/dromaeo/cssquery-prototype.html) 09:36:12 INFO - PROCESS | 1991 | RSS: Main: 337489920 09:36:12 INFO - PROCESS | 1991 | 09:39:15 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:49739/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49739/tests/dromaeo/cssquery-yui.html) 09:39:15 INFO - PROCESS | 1991 | RSS: Main: 337199104 09:39:15 INFO - PROCESS | 1991 | 09:42:18 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:49739/tests/dromaeo/cssquery-yui.html (next: http://localhost:49739/tests/dromaeo/cssquery-dojo.html) 09:42:18 INFO - PROCESS | 1991 | RSS: Main: 410812416 09:42:18 INFO - PROCESS | 1991 | 09:42:18 INFO - PROCESS | 1991 | __start_tp_report 09:42:18 INFO - PROCESS | 1991 | _x_x_mozilla_page_load 09:42:18 INFO - PROCESS | 1991 | _x_x_mozilla_page_load_details 09:42:18 INFO - PROCESS | 1991 | |i|pagename|runs| 09:42:18 INFO - PROCESS | 1991 | |0;dojo.html;3402.8298585070747;3446.8448919798607;3465.948010779838;3493.7379696522767;3529.48822420749;5541.5843811714085;5608.915866262004;5611.046122159232;5628.605997580171;5668.688222147785;5619.522340601044;5667.716614169296;5679.062954612495;5795.942040579593;5797.304323481178;5066.2907192992825;5077.3907131144315;5103.438621751604;5111.2333150027425;5247;5203.427622961472;5203.947960520403;5245.10833158364;5259;5301.992621401941;5062.594992400636;5064.645474816764;5161.406438259611;5176.663516871391;5185.144451165591;5150.201718733602;5154.896902061938;5162.638615296931;5170.741462926876;5181.896362072775;5099;5134.666246693953;5135.306733590992;5151.5106064923775;5169.844904652867;5476.205950137248;5560.86097847553;5608.523275521545;5681.346645135821;5690.943090569124;6148.784792532285;6169.537284703665;6174.351693072208;6177.042558403455;6186.783462578788;5679.346875109332;6223.87552248957;6224.221972253468;6250.249970003583;6259.467945224661;5597.216389705444;5640.802571909963;5699.202111704406;5701.401352857932;5764.596478246483;6256.092866534327;6275.02737075754;6284.308726040132;6285.214348206474;6290.339514350927;5993.130996005555;6037.547183961133;6081.6351018939;6094.238220222473;6104.725287362079;6099.664518451439;6123.4351415035735;6155.507559395238;6207.937920620736;6251.593646412968;6102.6338419694075;6122.0510820821955;6128.540359473057;6140.815775526741;6157.199564056644;6146.078088286793;6147.047207682816;6148.292946311142;6166.969165154145;6174.197354343906;4778.426588809365;4813.542713442217;4857.587105096036;4860.1008813369635;4866.5376789205675;4316.697831151852;4409.713368631029;4432.224360736923;4435.379046933432;4438.423005009393;5637.830865074055;5699.230603868507;5699.572532060112;5703.058995265817;5727.656340619576;6147.139400483936;6148.9692551536955;6150.569460137837;6164.6917654118015;6255.78104766331;5660.179274005329;5696.601237913306;5720.599558030898;5739.85650358736;5745.597808153389;5290.5238528531845;5298.311219541435;5301.0723123453245;5305.840824775263;5363.517283444508;5411.918821217685;6210.161628180138;6222.844428889314;6298.968505157445;6338.968305158444;6239.344868788893;6242;6259.467945224706;6269.373062693694;6271;6196.752129914933;6275.937240627535;6297.307296197506;6298.149749783721;6302.527310451643;6111.388861113853;6140.017597184429;6157.6613286269685;6162.044883043135;6177.505799536116;6200.534959878118;6235.220597425322;6247.344028877084;6254.593451425642;6254.843628909313;5877.441643043904;5880.26496687914;5977.9402205977385;6071.969640151771;6101.908471372844;5943.138244954544;5944.108383742473;5948.464638182584;5968;5973.104034394702;5812.593118481835;5846.883062338815;5848.619839710405;5863.794767183128;5873.73568189424;5891.1457838614015;5965.373635768182;6084.452399284086;6103.852895754643;6121.051237058263;5879.676617786063;5884;5887.470127688529;5894;5902.5277977762535 09:42:18 INFO - PROCESS | 1991 | |1;ext.html;454.9545045495453;467.09150701884846;496.48861672477364;575.4446958684869;611.6146827498675;29040.709592904066;29462.85268573657;36771.89684309471;37205.44191837118;37362.252754944886;39413.60586394135;39775.00562485939;39799.204015919735;39820.60179398205;40016.59983400165;9376.062393760638;9614.13472787449;9635.470049147294;9639.421634701905;9643.276754243425;9468.147866691996;9610.903890961106;9637.662681806138;9643.132118109368;9648.421094734304;9667.033296670346;9757.316987810857;9772.364796288253;9775.804483910317;9788.314817962746;9651.613935442574;9719.805603887882;9730.659426920023;9733.853992190123;9736.999999999965;9528.428294302295;9665.226781857435;9683.806323873554;9688.75778105546;9691.70924872255;37768.43347349792;38216.61783382186;38217.426738598944;38301.425478617566;38315.23369532594;3071.692830716933;3152.763542734304;3183.3951549205576;3322.9833850830832;3530.5763308403157;21818.563628727494;27631.723682763117;27707.445851083066;27797.444051119066;28217.858910705316;2581.264339663187;2612.71260161384;2647.48374067057;2661.2814540074264;2693.851838148901;471447;473454;473892;474798;475979;42652.57347426486;43341.13317733691;43344;43350;43452;42795.57204427978;43010.13979720388;43103.04315003752;43105.56894431016;43123.568764312586;14919.627009324637;15060.774088388684;15090.622734431507;15104.622384440478;15106.471273505374;10106.797864042825;12173.634790956285;12190.878091219152;12211.145219834527;12480.75038499243;12669.923056540112;13122.147060441232;14063.578092657237;14092.084014539023;14114.294285285694;6164.568480206342;6231.937680623136;6275.6548389839;6275.717592708339;6293.244810622663;765.5215490318551;876.5222953490363;939.9707320484059;956.3974695941652;975.770693886936;28139;28664.71335286662;28961;28961.855190723913;30025.04837185576;874.6413970272285;878.3587980774071;923.1783712495884;980.7548112971757;1034.6136177522155;13691.383887725076;13704.794428083587;13924.860751392356;14067.507637232648;14088.506902258372;634499;639654;640118;640417;902641;53793.92412151735;54464;54760.17859732107;54830.177547336825;54883.902321953334;1438.0724432740824;1461.7222727681706;1476.933537990793;1481.1631428243224;1481.3926290220957;23518.64722029137;26805;27711.30721731973;29081.418371632026;29904.25239369033;48008;48345;49040.50959490502;49058;49076.01847963092;440528;445800;446599;447977;448117;25653.615195771705;30819.69180308258;31244;31468.685313146576;31527.054188374386;31370.68629313769;40453.59546404616;40650.796746017266;41610.37584436296;41689;32962;34213;34461.31077378388;35041.824790876904;35081.473777893865;29096;33732.49401258934;34053.48919766156;34778.30443391169;34834.47748283727;27480.450390992468;29386.853065734533;29712.702872970993;34663.826680866434;34882.16296207466;27618.861905690344;30290.545641815832;30399.696003039688;30589.694103058686;32335.029949101565;23940.521189575764;24473.51052978895;25474.363140921625;25682.87158564195;26124.216273511825 09:42:18 INFO - PROCESS | 1991 | |2;jquery.html;311.8362859498761;358.8510768031267;363.0904584017037;367.7297186567872;370.9128354836611;16059.518214453556;16574.66850662986;19089.904550477244;19273.614527709437;21333.893330533345;11933.940330298336;11948.940255298712;11959.342236177006;11971.940140299286;16306.50391474011;5175.094358487268;5194.870128246786;5319.0957537218765;5369.973150134244;5377.704226267554;3236.676332366768;4097.549269580344;4763.642726795487;5399;5408.945910540883;4088.9591104088877;4089.5501494835694;4090.0797320602774;5304.151335786275;5935.228420305354;5896.498797602209;5902.085176797582;5911.586188966774;5919.993601087804;5976.432238937294;5435.157550579666;5438.374586922476;5441;5445.284735308365;5470.316210473691;12976.091673582852;13201.537946171933;18624.068796560117;24383.7561624385;24399;2056.23919149914;2229.342344008521;2319.420144963759;2732.7130651281527;2750.943003434974;8342.916570834275;9234.538273086386;10103.393796372242;11793.115516336224;15044.623884402868;1606.2771752711326;1646.6706658668195;1726.9050202238873;1752.8518820172808;1789.4899953513316;102952.48523757333;107612.4619376898;107902;113452.43273783661;115450.26824597637;9189.494577798285;11019;11274.774504509864;11306.491207895664;11314.208005439541;13670.11144275619;13698.246596437093;13709.17744935307;13719.176849388869;13735.931320343334;8398.454100483448;8420.073791882887;8450.577471126542;8474.025487068942;8556.871646925301;8536.274416674529;8542.487450752975;8545.957270213608;8627.482351058956;8645.567721613894;4469.307257375112;4494.235979883428;4501.437320334958;4520.412346395014;4549.886252843706;1762.118940529735;1853.8424233939998;1886.9339573114876;1896.473338962121;1932.1401976120492;835.4402550291198;880.5729221327651;965.792354643755;976.8095221431895;1000.9199264058858;19313.015575173667;19766.802331976498;19809.20763169486;19873;19961;751.3463286940397;907.5190149220923;922.3727865051695;928.1924725488868;963.9228861691048;9740.707778766648;10471.214658900613;10536.894631053592;10592.205584581186;10648.254622176373;494333;505383;507518;559733;638668;72574;119850.80149198396;124000.37999810124;127668.36165819112;129467.35266323609;1058.867641544807;1062.914966802654;1070.8768491623407;1111.7109551516503;1111.8888111188978;14357.425702971765;18021.63956720832;18385.632287354445;18442.538936526693;18581.49149864805;49540;51105.74447127741;52302;52689.73655131853;52730.73634631802;71015.28984710293;73721;76010;76464.61767691126;76882.6155869217;7756.961215193888;7978;8026.919730802617;8033.277005069572;8217.342612591097;10749.408782517037;13088.821243844039;13256.602301930958;13421;13632.182069075887;8027.719029833927;11426.82859757121;11508.712282193012;11698.005669517846;11814.586489472827;10395.740106497398;10962.081635713559;11367.261128026652;11580.536778529102;11745.588904388305;11360.46279672844;11832.76334473323;11840.407979601157;11908;12079.335636540074;7911.723089691834;8054.637541310538;8075.83848323042;8165.550894700848;8267.83464330722;11263.380514071805;11581.247218930743;11735.41322933867;11747.412629368668;11749.941250293694 09:42:18 INFO - PROCESS | 1991 | |3;mootools.html;1370.7464119137953;1502.7971223884776;1509.856563626455;1682.6802907447577;1747.8951262924224;7453.7763867084;8390.748277551676;8588.613512391941;8607.526586037766;8634.4387614805;8368;8587.52768597727;8590.226879580836;8605.225529702326;8616.009158946723;2404.134511575836;2426.2721183644926;2429.987850060756;2435.3181109289426;2436.025589764091;2392.8085753139794;2415;2434.9391265218333;2437.926862194137;2458.9549441487384;2417.6494408310787;2439.2072576412647;2444.877756112196;2445.254197469771;2447.3881529617597;2407.41018450479;2416.734159242482;2433;2434.817388695846;2438.1710218525786;2213.4577028627928;2276.578832915916;2372.9406764830846;2425.2845410603913;2432.8200822601025;8646.005709343443;8689;8697.913020869773;8700.390972631854;8703.782405439915;5285.339332583427;5406.621536492447;5412;5420.756065977041;5424.186372044185;3455.827208639583;3505.2463720300257;3557.1818481749083;3574.660407261306;3583.372909740785;990.5047476261869;1012.71643939697;1031.6750223679517;1045.2839804733705;1047.9056884880322;11739.23694959825;11745;11745.11911606633;11746.765064698659;11753.706157346049;4357.736256485584;4644.674872758875;4799.520047995243;4839.516048395132;4861.1979023460735;8432.156784321518;9025.41334813235;9733.124018838196;9909.554070066864;9912.504374781376;4829.396325459317;5167.044096842021;5374.220737992969;5378.2470454136455;5385.569154467712;4341.479022517255;4484.641228701696;4692.061587682477;4854.660173787801;4932.605391568666;3860.5560360558334;3865.3042452358845;3872.6514613684903;3915.6084391561185;3919.451276821247;1254.6110705681267;1283.786821453736;1289.4970961325091;1294.8769866862633;1297;945.2674177512483;960.711786464058;999.6051559633904;1064.1593141418348;1313.894888408925;6915.377616014583;7679.078510578766;7887.645055972495;7924.445288829842;7936.047674279123;1106.0709004436312;1114.3035602748282;1114.8327750837439;1172.6130376975577;1186.424584076722;6073.331933487313;6079.270487541523;6109.877802443926;6159.137720719103;6159.876802464015;10323.070923616911;10605.734856628646;10665.733356666145;10681.679549613524;10683.572657093784;10348.844767328495;10442.2168337375;10459.529321180566;10554.419506927039;10555.155587552978;7047.718091276394;8144.267015968591;8283.130271321425;8309.293710034715;8332.541710205996;7670.539767613961;7761.61191940412;7777.4166937478785;7804.921950780419;7810.10183828867;9244.630214791334;9400.34197606161;9419.85870211961;9498.14516693501;9601.903980960102;8259.587020649064;9450.43297402158;9829.803403932025;9848.261380396641;9889.159421448969;6570.11303474044;6768.424683901727;7035.261297563887;7194.4244460442;7275.417966562556;7987.84024319522;8026.197380261927;8053.154418785943;8054.758357249292;8085.63614637331;7054.576725396492;7183;7214.783556493314;7280.745173918887;7354.852902941804;6823.829404264933;6958.373746362851;7012.123484564429;7022.08712867324;7200.243974382614;7367.852642947004;7599.088109426683;7607;7628.160902300631;7630.313271805564;6820.3861652451515;6936.167659880846;6937.993990871396;6943.27095654949;6948.235694073749;6936.930630693629;6992.965035174995;7003.4747393944635;7007.264237255014;7008.229094799466 09:42:18 INFO - PROCESS | 1991 | |4;prototype.html;319.0778649702361;323.7232166497644;329.2066120649236;331.2348475022699;334.0529598588004;5709.971450142749;6295.866743986081;6584.2098948126295;6612.173478315211;6629.436497897673;6512.772052978146;6514.80455586332;6516.576422532544;6519.543631945754;6531.2489063757685;4886.022795440917;4900.289458028602;4906.1168989581865;4917.385326834145;4929.950700493003;4923.729194894279;4924.291639598225;4933.136701077315;4938.3086367908345;4945.480724523927;3937.5865534118934;4395.714278571899;4544.795484203219;4616.33063205835;4790.9520904791025;4786.1863483207935;4789.568938795508;4794.7842347094465;4797.112534181153;4842.878928026792;4168.583141685837;4169.895752606179;4174.186033723425;4175.457190565237;4185.518665353493;6072.36240194782;6125.785597504066;6296.811095667137;6302.401271879165;6310.179676642053;5608.859778505529;5613.298337707786;5617.4382561743905;5631.352394474647;5633.40849210831;6910.550814197061;6933.895991560131;6935.375816176568;6940.444764418834;6941.72233110675;4620.075984803019;4620.561046700558;4627.583517483409;4629.23617603095;4632.814687412533;6961.477889158283;7315.743948961814;7343.559386436831;7351.44864135192;7358.190599034102;4690.906181876343;4748.833790817304;4751.3348131261655;4757.286407038971;4764.404449443819;4813.229883218668;4820.25286080658;4834.347363105936;4835.685680430831;4838.080764654705;5600.663960162403;5623.718814059281;5636;5642.351129620146;5653.575981801381;6006.399360064046;6572.277049524549;6934.618595977269;6941.861162776817;6968.233494315621;1666.125284225767;1687.190148728617;1688.1727953302793;1693.381915600797;1693.449628870622;871.8430682477215;1001.8246806808779;1026.0765311219814;1051.8685164354456;1052.315994603514;6503.902441463382;6571.704273307712;6573.408393244536;6575.572587781779;6586.110875031905;7015.719371225094;7181.461390395742;7192.856142877114;7203.567785932861;7232.20445750967;6651.63416012124;6657.933420665829;6661.467082633378;6661.833454163588;6662.167229096363;3836.8081595920094;3870.3420418528917;3870.9612903871166;3873.7288389812443;3879.631435013669;7548.811279718051;7549.698012079565;7554.546727196386;7575.128860181149;7585.962070189614;6587.769428070091;6590.077389165521;6945.791626251221;7161.89257161143;7420;6950.165980082423;7478.597238256581;7533.660985255677;7621.657025433758;7668.923310766821;7326.487145899736;7334.193238743841;7340.486165968331;7340.669669864762;7356.816079598053;7176.569405835667;7180.210176880643;7180.461465390221;7184.317489838457;7191.820204494929;5831.7667293307795;7469.514481558681;7506.549607023596;7540.17058123595;7594.240575942362;4566.383538222298;4583.427071616048;4617.861464156081;4619.099275641218;4624.213883639856;7200.243974382614;7208.243134471015;7212.4590655699985;7215.422766178798;7236.167840698387;5721.685307308138;7024.719011239493;7043.154821421463;7050.894236586558;7056.188538317954;6662.533622646368;6964.582125072512;6965.373116419547;6977.232504424408;6996.755113571001;6834.760783372558;6853.520253582202;6868;6877.6217308048535;6896.862062758817;5778.27771528559;7033.964830175816;7041.471889608198;7041.647917604202;7045.542039767399;5213.921791173059;6683.663267346453;6870.828229294308;6875.7937261882225;6886.8622627548175 09:42:18 INFO - PROCESS | 1991 | |5;yui.html;629.7921685843672;637.5600835423558;642.2389468479848;642.4763817488749;688.6866475753533;13863.445462181513;14093.647658808522;14109.929450352747;14126.43494260231;14139.08095973761;13303.667408314797;13486.46054157835;13495.987800914922;13497.662558436044;13519.121257118304;696.14721965592;709.3474003916383;847.8431490174322;856.0968178571604;874.3442418186361;850.6894983331101;855.9871601925976;858.9527575983318;861.7974775927684;864.1229152410277;737.4321772235376;914.5244472874135;915.1169121797465;915.748169253454;917.7338571814166;898.2634239923266;911.3802614222326;913.2328843771197;913.2739472119681;913.9405938613969;674.6390680985699;675.8513127112027;675.8783418984581;676.8578598494322;679.6092246957969;14049.859501404957;14136.010479266455;14142.434302627986;14146.08050476726;14171.78742318866;12365.31990740509;12500.249985000839;12582.24506529611;12623.431945562379;12802.80795788064;9936.105750482491;9988.1510071644;10079.59681612742;10124.392536447836;10688.519016644192;3146.11908665574;3155.3689262147664;3177.4757165067736;3218.4206842768294;3230.7415406767404;69423.61152776967;69532.652336738;75300.62349688272;79502;79932.60033699853;8135.552544609985;9461.385009974467;9471.47906865129;9484.95257523708;9521.952390238004;20443.59112817735;20643.277485288243;20704.58590828175;21666.133354665635;21669.241576544744;7356.742514011984;7484.962575187089;7533.849323013509;7621;7662.118856331482;3970.7220494565104;4019.577944315863;4026.1142548639255;4032.9917520619847;4036.29364861154;3508.7017603503477;3540.185757275841;3548.733844961638;3550.591681956608;3552.5381700379303;574.5030548575536;635.5836926812945;644.5713600455645;645.2128403347908;667.1260648550415;574.2620732358982;602.9095635654687;610.0452791381474;622.7477871462065;627.7834147219202;8168.428210025241;8357.874631880526;8505.23452889243;8533.914660853312;8585.871211931826;472.98868488365713;545.7625932719279;559.4182050667342;608.2275510102146;609.2171559546051;3877.941830872539;3899.863504777319;4024.9798751006056;4027.9798601006805;4082.510098788164;82164.58917705373;83621.74567381495;83985;84178;84272.73590896142;83106;83451.5827420859;83896.58051709825;84058.5797071023;84769.57615211884;74114.14714632177;74773.13067173255;74865;74965.50068998699;75540;7714.884276735966;7770.339521140766;7922.128565857636;8069.435139540175;8112.269895709414;50465.74767126141;51457.742711286206;52102.478975209764;52753.20870186874;53227;65717.34282657113;67593.6481270362;72085;72138.91791623234;72940;8288.005439347076;9658.9034109658;9739.41563506192;9920.702378928643;9985.700428987142;9297.67458138962;10754;10853.131749460183;11073.446327683423;11612.767744645229;10113.393196408239;10349.586016559253;10382.42896640692;10460.476976151314;10560.366378017343;10282.640107596199;10302.278840481395;10306.381617102998;10413.47932603382;10566.418846963183;10175.592976280866;10286.948565257126;10299.279050466695;10401.739956501147;10410.271281010257;8565.229129378386;8695.956520217358;8872.778180545538;8934.195922367018;9086.045965173562;8682.43564168327;8740.388172827841;8747.125287471203;8853.911460885309;8967.058458861726 09:42:18 INFO - PROCESS | 1991 | __end_tp_report 09:42:18 INFO - PROCESS | 1991 | __start_cc_report 09:42:18 INFO - PROCESS | 1991 | _x_x_mozilla_cycle_collect,982 09:42:18 INFO - PROCESS | 1991 | __end_cc_report 09:42:18 INFO - PROCESS | 1991 | __startTimestamp1456335738803__endTimestamp 09:42:18 INFO - PROCESS | 1991 | 09:42:18 INFO - PROCESS | 1991 | ------- Summary: start ------- 09:42:18 INFO - PROCESS | 1991 | Number of tests: 6 09:42:18 INFO - PROCESS | 1991 | 09:42:18 INFO - PROCESS | 1991 | [#0] dojo.html Cycles:165 Average:5691.59 Median:5877.44 stddev:619.35 (10.5%) stddev-sans-first:594.65 09:42:18 INFO - PROCESS | 1991 | Values: 3402.8 3446.8 3465.9 3493.7 3529.5 5541.6 5608.9 5611.0 5628.6 5668.7 5619.5 5667.7 5679.1 5795.9 5797.3 5066.3 5077.4 5103.4 5111.2 5247.0 5203.4 5203.9 5245.1 5259.0 5302.0 5062.6 5064.6 5161.4 5176.7 5185.1 5150.2 5154.9 5162.6 5170.7 5181.9 5099.0 5134.7 5135.3 5151.5 5169.8 5476.2 5560.9 5608.5 5681.3 5690.9 6148.8 6169.5 6174.4 6177.0 6186.8 5679.3 6223.9 6224.2 6250.2 6259.5 5597.2 5640.8 5699.2 5701.4 5764.6 6256.1 6275.0 6284.3 6285.2 6290.3 5993.1 6037.5 6081.6 6094.2 6104.7 6099.7 6123.4 6155.5 6207.9 6251.6 6102.6 6122.1 6128.5 6140.8 6157.2 6146.1 6147.0 6148.3 6167.0 6174.2 4778.4 4813.5 4857.6 4860.1 4866.5 4316.7 4409.7 4432.2 4435.4 4438.4 5637.8 5699.2 5699.6 5703.1 5727.7 6147.1 6149.0 6150.6 6164.7 6255.8 5660.2 5696.6 5720.6 5739.9 5745.6 5290.5 5298.3 5301.1 5305.8 5363.5 5411.9 6210.2 6222.8 6299.0 6339.0 6239.3 6242.0 6259.5 6269.4 6271.0 6196.8 6275.9 6297.3 6298.1 6302.5 6111.4 6140.0 6157.7 6162.0 6177.5 6200.5 6235.2 6247.3 6254.6 6254.8 5877.4 5880.3 5977.9 6072.0 6101.9 5943.1 5944.1 5948.5 5968.0 5973.1 5812.6 5846.9 5848.6 5863.8 5873.7 5891.1 5965.4 6084.5 6103.9 6121.1 5879.7 5884.0 5887.5 5894.0 5902.5 09:42:18 INFO - PROCESS | 1991 | 09:42:18 INFO - PROCESS | 1991 | [#1] ext.html Cycles:180 Average:64939.05 Median:38308.33 stddev:148074.91 (386.5%) stddev-sans-first:148411.15 09:42:18 INFO - PROCESS | 1991 | Values: 455.0 467.1 496.5 575.4 611.6 29040.7 29462.9 36771.9 37205.4 37362.3 39413.6 39775.0 39799.2 39820.6 40016.6 9376.1 9614.1 9635.5 9639.4 9643.3 9468.1 9610.9 9637.7 9643.1 9648.4 9667.0 9757.3 9772.4 9775.8 9788.3 9651.6 9719.8 9730.7 9733.9 9737.0 9528.4 9665.2 9683.8 9688.8 9691.7 37768.4 38216.6 38217.4 38301.4 38315.2 3071.7 3152.8 3183.4 3323.0 3530.6 21818.6 27631.7 27707.4 27797.4 28217.9 2581.3 2612.7 2647.5 2661.3 2693.9 471447.0 473454.0 473892.0 474798.0 475979.0 42652.6 43341.1 43344.0 43350.0 43452.0 42795.6 43010.1 43103.0 43105.6 43123.6 14919.6 15060.8 15090.6 15104.6 15106.5 10106.8 12173.6 12190.9 12211.1 12480.8 12669.9 13122.1 14063.6 14092.1 14114.3 6164.6 6231.9 6275.7 6275.7 6293.2 765.5 876.5 940.0 956.4 975.8 28139.0 28664.7 28961.0 28961.9 30025.0 874.6 878.4 923.2 980.8 1034.6 13691.4 13704.8 13924.9 14067.5 14088.5 634499.0 639654.0 640118.0 640417.0 902641.0 53793.9 54464.0 54760.2 54830.2 54883.9 1438.1 1461.7 1476.9 1481.2 1481.4 23518.6 26805.0 27711.3 29081.4 29904.3 48008.0 48345.0 49040.5 49058.0 49076.0 440528.0 445800.0 446599.0 447977.0 448117.0 25653.6 30819.7 31244.0 31468.7 31527.1 31370.7 40453.6 40650.8 41610.4 41689.0 32962.0 34213.0 34461.3 35041.8 35081.5 29096.0 33732.5 34053.5 34778.3 34834.5 27480.5 29386.9 29712.7 34663.8 34882.2 27618.9 30290.5 30399.7 30589.7 32335.0 23940.5 24473.5 25474.4 25682.9 26124.2 09:42:18 INFO - PROCESS | 1991 | 09:42:18 INFO - PROCESS | 1991 | [#2] jquery.html Cycles:180 Average:32114.81 Median:13351.59 stddev:90888.66 (680.7%) stddev-sans-first:91112.26 09:42:18 INFO - PROCESS | 1991 | Values: 311.8 358.9 363.1 367.7 370.9 16059.5 16574.7 19089.9 19273.6 21333.9 11933.9 11948.9 11959.3 11971.9 16306.5 5175.1 5194.9 5319.1 5370.0 5377.7 3236.7 4097.5 4763.6 5399.0 5408.9 4089.0 4089.6 4090.1 5304.2 5935.2 5896.5 5902.1 5911.6 5920.0 5976.4 5435.2 5438.4 5441.0 5445.3 5470.3 12976.1 13201.5 18624.1 24383.8 24399.0 2056.2 2229.3 2319.4 2732.7 2750.9 8342.9 9234.5 10103.4 11793.1 15044.6 1606.3 1646.7 1726.9 1752.9 1789.5 102952.5 107612.5 107902.0 113452.4 115450.3 9189.5 11019.0 11274.8 11306.5 11314.2 13670.1 13698.2 13709.2 13719.2 13735.9 8398.5 8420.1 8450.6 8474.0 8556.9 8536.3 8542.5 8546.0 8627.5 8645.6 4469.3 4494.2 4501.4 4520.4 4549.9 1762.1 1853.8 1886.9 1896.5 1932.1 835.4 880.6 965.8 976.8 1000.9 19313.0 19766.8 19809.2 19873.0 19961.0 751.3 907.5 922.4 928.2 963.9 9740.7 10471.2 10536.9 10592.2 10648.3 494333.0 505383.0 507518.0 559733.0 638668.0 72574.0 119850.8 124000.4 127668.4 129467.4 1058.9 1062.9 1070.9 1111.7 1111.9 14357.4 18021.6 18385.6 18442.5 18581.5 49540.0 51105.7 52302.0 52689.7 52730.7 71015.3 73721.0 76010.0 76464.6 76882.6 7757.0 7978.0 8026.9 8033.3 8217.3 10749.4 13088.8 13256.6 13421.0 13632.2 8027.7 11426.8 11508.7 11698.0 11814.6 10395.7 10962.1 11367.3 11580.5 11745.6 11360.5 11832.8 11840.4 11908.0 12079.3 7911.7 8054.6 8075.8 8165.6 8267.8 11263.4 11581.2 11735.4 11747.4 11749.9 09:42:18 INFO - PROCESS | 1991 | 09:42:18 INFO - PROCESS | 1991 | [#3] mootools.html Cycles:180 Average:5902.39 Median:5748.76 stddev:3108.28 (54.1%) stddev-sans-first:3098.33 09:42:18 INFO - PROCESS | 1991 | Values: 1370.7 1502.8 1509.9 1682.7 1747.9 7453.8 8390.7 8588.6 8607.5 8634.4 8368.0 8587.5 8590.2 8605.2 8616.0 2404.1 2426.3 2430.0 2435.3 2436.0 2392.8 2415.0 2434.9 2437.9 2459.0 2417.6 2439.2 2444.9 2445.3 2447.4 2407.4 2416.7 2433.0 2434.8 2438.2 2213.5 2276.6 2372.9 2425.3 2432.8 8646.0 8689.0 8697.9 8700.4 8703.8 5285.3 5406.6 5412.0 5420.8 5424.2 3455.8 3505.2 3557.2 3574.7 3583.4 990.5 1012.7 1031.7 1045.3 1047.9 11739.2 11745.0 11745.1 11746.8 11753.7 4357.7 4644.7 4799.5 4839.5 4861.2 8432.2 9025.4 9733.1 9909.6 9912.5 4829.4 5167.0 5374.2 5378.2 5385.6 4341.5 4484.6 4692.1 4854.7 4932.6 3860.6 3865.3 3872.7 3915.6 3919.5 1254.6 1283.8 1289.5 1294.9 1297.0 945.3 960.7 999.6 1064.2 1313.9 6915.4 7679.1 7887.6 7924.4 7936.0 1106.1 1114.3 1114.8 1172.6 1186.4 6073.3 6079.3 6109.9 6159.1 6159.9 10323.1 10605.7 10665.7 10681.7 10683.6 10348.8 10442.2 10459.5 10554.4 10555.2 7047.7 8144.3 8283.1 8309.3 8332.5 7670.5 7761.6 7777.4 7804.9 7810.1 9244.6 9400.3 9419.9 9498.1 9601.9 8259.6 9450.4 9829.8 9848.3 9889.2 6570.1 6768.4 7035.3 7194.4 7275.4 7987.8 8026.2 8053.2 8054.8 8085.6 7054.6 7183.0 7214.8 7280.7 7354.9 6823.8 6958.4 7012.1 7022.1 7200.2 7367.9 7599.1 7607.0 7628.2 7630.3 6820.4 6936.2 6938.0 6943.3 6948.2 6936.9 6993.0 7003.5 7007.3 7008.2 09:42:18 INFO - PROCESS | 1991 | 09:42:18 INFO - PROCESS | 1991 | [#4] prototype.html Cycles:180 Average:5703.21 Median:6525.40 stddev:1798.53 (27.6%) stddev-sans-first:1757.58 09:42:18 INFO - PROCESS | 1991 | Values: 319.1 323.7 329.2 331.2 334.1 5710.0 6295.9 6584.2 6612.2 6629.4 6512.8 6514.8 6516.6 6519.5 6531.2 4886.0 4900.3 4906.1 4917.4 4930.0 4923.7 4924.3 4933.1 4938.3 4945.5 3937.6 4395.7 4544.8 4616.3 4791.0 4786.2 4789.6 4794.8 4797.1 4842.9 4168.6 4169.9 4174.2 4175.5 4185.5 6072.4 6125.8 6296.8 6302.4 6310.2 5608.9 5613.3 5617.4 5631.4 5633.4 6910.6 6933.9 6935.4 6940.4 6941.7 4620.1 4620.6 4627.6 4629.2 4632.8 6961.5 7315.7 7343.6 7351.4 7358.2 4690.9 4748.8 4751.3 4757.3 4764.4 4813.2 4820.3 4834.3 4835.7 4838.1 5600.7 5623.7 5636.0 5642.4 5653.6 6006.4 6572.3 6934.6 6941.9 6968.2 1666.1 1687.2 1688.2 1693.4 1693.4 871.8 1001.8 1026.1 1051.9 1052.3 6503.9 6571.7 6573.4 6575.6 6586.1 7015.7 7181.5 7192.9 7203.6 7232.2 6651.6 6657.9 6661.5 6661.8 6662.2 3836.8 3870.3 3871.0 3873.7 3879.6 7548.8 7549.7 7554.5 7575.1 7586.0 6587.8 6590.1 6945.8 7161.9 7420.0 6950.2 7478.6 7533.7 7621.7 7668.9 7326.5 7334.2 7340.5 7340.7 7356.8 7176.6 7180.2 7180.5 7184.3 7191.8 5831.8 7469.5 7506.5 7540.2 7594.2 4566.4 4583.4 4617.9 4619.1 4624.2 7200.2 7208.2 7212.5 7215.4 7236.2 5721.7 7024.7 7043.2 7050.9 7056.2 6662.5 6964.6 6965.4 6977.2 6996.8 6834.8 6853.5 6868.0 6877.6 6896.9 5778.3 7034.0 7041.5 7041.6 7045.5 5213.9 6683.7 6870.8 6875.8 6886.9 09:42:18 INFO - PROCESS | 1991 | 09:42:18 INFO - PROCESS | 1991 | [#5] yui.html Cycles:180 Average:17997.92 Median:33192.23 stddev:25624.05 (77.2%) stddev-sans-first:25662.74 09:42:18 INFO - PROCESS | 1991 | Values: 629.8 637.6 642.2 642.5 688.7 13863.4 14093.6 14109.9 14126.4 14139.1 13303.7 13486.5 13496.0 13497.7 13519.1 696.1 709.3 847.8 856.1 874.3 850.7 856.0 859.0 861.8 864.1 737.4 914.5 915.1 915.7 917.7 898.3 911.4 913.2 913.3 913.9 674.6 675.9 675.9 676.9 679.6 14049.9 14136.0 14142.4 14146.1 14171.8 12365.3 12500.2 12582.2 12623.4 12802.8 9936.1 9988.2 10079.6 10124.4 10688.5 3146.1 3155.4 3177.5 3218.4 3230.7 69423.6 69532.7 75300.6 79502.0 79932.6 8135.6 9461.4 9471.5 9485.0 9522.0 20443.6 20643.3 20704.6 21666.1 21669.2 7356.7 7485.0 7533.8 7621.0 7662.1 3970.7 4019.6 4026.1 4033.0 4036.3 3508.7 3540.2 3548.7 3550.6 3552.5 574.5 635.6 644.6 645.2 667.1 574.3 602.9 610.0 622.7 627.8 8168.4 8357.9 8505.2 8533.9 8585.9 473.0 545.8 559.4 608.2 609.2 3877.9 3899.9 4025.0 4028.0 4082.5 82164.6 83621.7 83985.0 84178.0 84272.7 83106.0 83451.6 83896.6 84058.6 84769.6 74114.1 74773.1 74865.0 74965.5 75540.0 7714.9 7770.3 7922.1 8069.4 8112.3 50465.7 51457.7 52102.5 52753.2 53227.0 65717.3 67593.6 72085.0 72138.9 72940.0 8288.0 9658.9 9739.4 9920.7 9985.7 9297.7 10754.0 10853.1 11073.4 11612.8 10113.4 10349.6 10382.4 10460.5 10560.4 10282.6 10302.3 10306.4 10413.5 10566.4 10175.6 10286.9 10299.3 10401.7 10410.3 8565.2 8696.0 8872.8 8934.2 9086.0 8682.4 8740.4 8747.1 8853.9 8967.1 09:42:18 INFO - PROCESS | 1991 | -------- Summary: end -------- 09:42:18 INFO - PROCESS | 1991 | 09:42:19 INFO - TEST-INFO | 1991: exit 0 09:42:19 INFO - TEST-OK | dromaeo_css | took 1114171ms 09:42:19 INFO - TEST-START | kraken 09:42:19 INFO - operating with platform_type : mac_ 09:42:19 INFO - Initialising browser for kraken test... 09:42:19 INFO - TEST-INFO | started process 1995 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/tmpie04hD/profile http://localhost:49739/getInfo.html) 09:42:21 INFO - PROCESS | 1995 | __metrics Screen width/height:1600/1200 09:42:21 INFO - PROCESS | 1995 | colorDepth:24 09:42:21 INFO - PROCESS | 1995 | Browser inner width/height: 1024/689 09:42:21 INFO - PROCESS | 1995 | __metrics 09:42:21 INFO - PROCESS | 1995 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:42:21 INFO - PROCESS | 1995 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:42:22 INFO - TEST-INFO | 1995: exit 0 09:42:22 INFO - Browser initialized. 09:42:22 INFO - Running cycle 1/1 for kraken test... 09:42:22 INFO - TEST-INFO | started process 1997 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/tmpie04hD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:42:34 INFO - PROCESS | 1997 | RSS: Main: 244580352 09:42:34 INFO - PROCESS | 1997 | 09:42:36 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:49739/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49739/tests/kraken/driver.html?testName=audio-beat-detection) 09:42:37 INFO - PROCESS | 1997 | RSS: Main: 289959936 09:42:37 INFO - PROCESS | 1997 | 09:42:40 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:49739/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49739/tests/kraken/driver.html?testName=audio-dft) 09:42:40 INFO - PROCESS | 1997 | RSS: Main: 301600768 09:42:40 INFO - PROCESS | 1997 | 09:42:43 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:49739/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49739/tests/kraken/driver.html?testName=audio-fft) 09:42:44 INFO - PROCESS | 1997 | RSS: Main: 285585408 09:42:44 INFO - PROCESS | 1997 | 09:42:46 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:49739/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49739/tests/kraken/driver.html?testName=audio-oscillator) 09:42:47 INFO - PROCESS | 1997 | RSS: Main: 286597120 09:42:47 INFO - PROCESS | 1997 | 09:42:49 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:49739/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49739/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:42:49 INFO - PROCESS | 1997 | RSS: Main: 290160640 09:42:49 INFO - PROCESS | 1997 | 09:42:52 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:49739/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49739/tests/kraken/driver.html?testName=imaging-darkroom) 09:42:53 INFO - PROCESS | 1997 | RSS: Main: 289501184 09:42:53 INFO - PROCESS | 1997 | 09:42:55 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:49739/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49739/tests/kraken/driver.html?testName=imaging-desaturate) 09:42:56 INFO - PROCESS | 1997 | RSS: Main: 289845248 09:42:56 INFO - PROCESS | 1997 | 09:42:59 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:49739/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49739/tests/kraken/driver.html?testName=json-parse-financial) 09:42:59 INFO - PROCESS | 1997 | RSS: Main: 288931840 09:42:59 INFO - PROCESS | 1997 | 09:43:01 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:49739/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49739/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:43:01 INFO - PROCESS | 1997 | RSS: Main: 324661248 09:43:01 INFO - PROCESS | 1997 | 09:43:03 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:49739/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49739/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:43:04 INFO - PROCESS | 1997 | RSS: Main: 323244032 09:43:04 INFO - PROCESS | 1997 | 09:43:06 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:49739/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49739/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:43:06 INFO - PROCESS | 1997 | RSS: Main: 332689408 09:43:06 INFO - PROCESS | 1997 | 09:43:09 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:49739/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49739/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:43:10 INFO - PROCESS | 1997 | RSS: Main: 333488128 09:43:10 INFO - PROCESS | 1997 | 09:43:12 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:49739/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49739/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:43:13 INFO - PROCESS | 1997 | RSS: Main: 333950976 09:43:13 INFO - PROCESS | 1997 | 09:43:14 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:49739/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49739/tests/kraken/driver.html?testName=ai-astar) 09:43:15 INFO - PROCESS | 1997 | RSS: Main: 393822208 09:43:15 INFO - PROCESS | 1997 | 09:43:15 INFO - PROCESS | 1997 | __start_tp_report 09:43:15 INFO - PROCESS | 1997 | _x_x_mozilla_page_load 09:43:15 INFO - PROCESS | 1997 | _x_x_mozilla_page_load_details 09:43:15 INFO - PROCESS | 1997 | |i|pagename|runs| 09:43:15 INFO - PROCESS | 1997 | |0;ai-astar;110;107;110;111;111;110;115;110;111;111 09:43:15 INFO - PROCESS | 1997 | |1;audio-beat-detection;161;119;161;189;120;145;141;122;160;120 09:43:15 INFO - PROCESS | 1997 | |2;audio-dft;185;186;187;183;186;185;187;182;179;191 09:43:15 INFO - PROCESS | 1997 | |3;audio-fft;77;75;85;77;56;59;57;82;76;55 09:43:15 INFO - PROCESS | 1997 | |4;audio-oscillator;93;92;129;79;80;83;112;78;79;115 09:43:15 INFO - PROCESS | 1997 | |5;imaging-gaussian-blur;84;105;131;89;84;89;83;90;84;88 09:43:15 INFO - PROCESS | 1997 | |6;imaging-darkroom;94;92;93;92;98;93;94;92;93;93 09:43:15 INFO - PROCESS | 1997 | |7;imaging-desaturate;84;86;85;86;85;88;90;87;86;85 09:43:15 INFO - PROCESS | 1997 | |8;json-parse-financial;54;53;52;52;52;52;54;65;52;52 09:43:15 INFO - PROCESS | 1997 | |9;json-stringify-tinderbox;64;70;66;73;69;67;67;67;67;68 09:43:15 INFO - PROCESS | 1997 | |10;stanford-crypto-aes;83;84;83;107;84;82;82;82;84;84 09:43:15 INFO - PROCESS | 1997 | |11;stanford-crypto-ccm;124;133;124;113;138;104;124;126;125;130 09:43:15 INFO - PROCESS | 1997 | |12;stanford-crypto-pbkdf2;139;127;137;138;139;126;139;129;138;136 09:43:15 INFO - PROCESS | 1997 | |13;stanford-crypto-sha256-iterative;68;67;67;67;67;66;66;66;67;67 09:43:15 INFO - PROCESS | 1997 | __end_tp_report 09:43:15 INFO - PROCESS | 1997 | __start_cc_report 09:43:15 INFO - PROCESS | 1997 | _x_x_mozilla_cycle_collect,1163 09:43:15 INFO - PROCESS | 1997 | __end_cc_report 09:43:15 INFO - PROCESS | 1997 | __startTimestamp1456335795060__endTimestamp 09:43:15 INFO - PROCESS | 1997 | 09:43:15 INFO - PROCESS | 1997 | ------- Summary: start ------- 09:43:15 INFO - PROCESS | 1997 | Number of tests: 14 09:43:15 INFO - PROCESS | 1997 | 09:43:15 INFO - PROCESS | 1997 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.00 stddev:1.96 (1.8%) stddev-sans-first:2.06 09:43:15 INFO - PROCESS | 1997 | Values: 110.0 107.0 110.0 111.0 111.0 110.0 115.0 110.0 111.0 111.0 09:43:15 INFO - PROCESS | 1997 | 09:43:15 INFO - PROCESS | 1997 | [#1] audio-beat-detection Cycles:10 Average:143.80 Median:152.50 stddev:23.87 (15.7%) stddev-sans-first:24.50 09:43:15 INFO - PROCESS | 1997 | Values: 161.0 119.0 161.0 189.0 120.0 145.0 141.0 122.0 160.0 120.0 09:43:15 INFO - PROCESS | 1997 | 09:43:15 INFO - PROCESS | 1997 | [#2] audio-dft Cycles:10 Average:185.10 Median:186.00 stddev:3.25 (1.7%) stddev-sans-first:3.44 09:43:15 INFO - PROCESS | 1997 | Values: 185.0 186.0 187.0 183.0 186.0 185.0 187.0 182.0 179.0 191.0 09:43:15 INFO - PROCESS | 1997 | 09:43:15 INFO - PROCESS | 1997 | [#3] audio-fft Cycles:10 Average:69.90 Median:76.50 stddev:11.73 (15.3%) stddev-sans-first:12.16 09:43:15 INFO - PROCESS | 1997 | Values: 77.0 75.0 85.0 77.0 56.0 59.0 57.0 82.0 76.0 55.0 09:43:15 INFO - PROCESS | 1997 | 09:43:15 INFO - PROCESS | 1997 | [#4] audio-oscillator Cycles:10 Average:94.00 Median:79.50 stddev:18.31 (23.0%) stddev-sans-first:19.42 09:43:15 INFO - PROCESS | 1997 | Values: 93.0 92.0 129.0 79.0 80.0 83.0 112.0 78.0 79.0 115.0 09:43:15 INFO - PROCESS | 1997 | 09:43:15 INFO - PROCESS | 1997 | [#5] imaging-gaussian-blur Cycles:10 Average:92.70 Median:86.00 stddev:14.89 (17.3%) stddev-sans-first:15.46 09:43:15 INFO - PROCESS | 1997 | Values: 84.0 105.0 131.0 89.0 84.0 89.0 83.0 90.0 84.0 88.0 09:43:15 INFO - PROCESS | 1997 | 09:43:15 INFO - PROCESS | 1997 | [#6] imaging-darkroom Cycles:10 Average:93.40 Median:93.00 stddev:1.78 (1.9%) stddev-sans-first:1.87 09:43:15 INFO - PROCESS | 1997 | Values: 94.0 92.0 93.0 92.0 98.0 93.0 94.0 92.0 93.0 93.0 09:43:15 INFO - PROCESS | 1997 | 09:43:15 INFO - PROCESS | 1997 | [#7] imaging-desaturate Cycles:10 Average:86.20 Median:86.00 stddev:1.75 (2.0%) stddev-sans-first:1.67 09:43:15 INFO - PROCESS | 1997 | Values: 84.0 86.0 85.0 86.0 85.0 88.0 90.0 87.0 86.0 85.0 09:43:15 INFO - PROCESS | 1997 | 09:43:15 INFO - PROCESS | 1997 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:52.50 stddev:4.02 (7.7%) stddev-sans-first:4.27 09:43:15 INFO - PROCESS | 1997 | Values: 54.0 53.0 52.0 52.0 52.0 52.0 54.0 65.0 52.0 52.0 09:43:15 INFO - PROCESS | 1997 | 09:43:15 INFO - PROCESS | 1997 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:67.50 stddev:2.44 (3.6%) stddev-sans-first:2.17 09:43:15 INFO - PROCESS | 1997 | Values: 64.0 70.0 66.0 73.0 69.0 67.0 67.0 67.0 67.0 68.0 09:43:15 INFO - PROCESS | 1997 | 09:43:15 INFO - PROCESS | 1997 | [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:83.50 stddev:7.60 (9.1%) stddev-sans-first:8.01 09:43:15 INFO - PROCESS | 1997 | Values: 83.0 84.0 83.0 107.0 84.0 82.0 82.0 82.0 84.0 84.0 09:43:15 INFO - PROCESS | 1997 | 09:43:15 INFO - PROCESS | 1997 | [#11] stanford-crypto-ccm Cycles:10 Average:124.10 Median:125.50 stddev:9.65 (7.7%) stddev-sans-first:10.24 09:43:15 INFO - PROCESS | 1997 | Values: 124.0 133.0 124.0 113.0 138.0 104.0 124.0 126.0 125.0 130.0 09:43:15 INFO - PROCESS | 1997 | 09:43:15 INFO - PROCESS | 1997 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:134.80 Median:138.00 stddev:5.29 (3.8%) stddev-sans-first:5.39 09:43:15 INFO - PROCESS | 1997 | Values: 139.0 127.0 137.0 138.0 139.0 126.0 139.0 129.0 138.0 136.0 09:43:15 INFO - PROCESS | 1997 | 09:43:15 INFO - PROCESS | 1997 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:0.63 (0.9%) stddev-sans-first:0.50 09:43:15 INFO - PROCESS | 1997 | Values: 68.0 67.0 67.0 67.0 67.0 66.0 66.0 66.0 67.0 67.0 09:43:15 INFO - PROCESS | 1997 | -------- Summary: end -------- 09:43:15 INFO - PROCESS | 1997 | 09:43:15 INFO - TEST-INFO | 1997: exit 0 09:43:15 INFO - TEST-OK | kraken | took 56640ms 09:43:15 INFO - SUITE-END | took 1170s 09:43:16 INFO - Completed test suite (00:19:31) 09:43:16 INFO - Working with test: dromaeo_css 09:43:16 INFO - Generating results file: dromaeo_css 09:43:16 INFO - Working with test: kraken 09:43:16 INFO - Generating results file: kraken 09:43:16 INFO - javascript benchmark 09:43:16 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:43:16 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 09:43:16 INFO - process_Request line: dromaeo_css 7305.21 graph.html#tests=[[72,64,59]] 09:43:16 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:43:16 INFO - process_Request line: kraken 1408.50 graph.html#tests=[[232,64,59]] 09:43:16 INFO - RETURN: dromaeo_css: 7305.21 09:43:16 INFO - RETURN: kraken: 1408.50 09:43:16 INFO - javascript benchmark 09:43:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3402.8298585070747, 3446.8448919798607, 3465.948010779838, 3493.7379696522767, 3529.48822420749, 5541.5843811714085, 5608.915866262004, 5611.046122159232, 5628.605997580171, 5668.688222147785, 5619.522340601044, 5667.716614169296, 5679.062954612495, 5795.942040579593, 5797.304323481178, 5066.2907192992825, 5077.3907131144315, 5103.438621751604, 5111.2333150027425, 5247.0, 5203.427622961472, 5203.947960520403, 5245.10833158364, 5259.0, 5301.992621401941, 5062.594992400636, 5064.645474816764, 5161.406438259611, 5176.663516871391, 5185.144451165591, 5150.201718733602, 5154.896902061938, 5162.638615296931, 5170.741462926876, 5181.896362072775, 5099.0, 5134.666246693953, 5135.306733590992, 5151.5106064923775, 5169.844904652867, 5476.205950137248, 5560.86097847553, 5608.523275521545, 5681.346645135821, 5690.943090569124, 6148.784792532285, 6169.537284703665, 6174.351693072208, 6177.042558403455, 6186.783462578788, 5679.346875109332, 6223.87552248957, 6224.221972253468, 6250.249970003583, 6259.467945224661, 5597.216389705444, 5640.802571909963, 5699.202111704406, 5701.401352857932, 5764.596478246483, 6256.092866534327, 6275.02737075754, 6284.308726040132, 6285.214348206474, 6290.339514350927, 5993.130996005555, 6037.547183961133, 6081.6351018939, 6094.238220222473, 6104.725287362079, 6099.664518451439, 6123.4351415035735, 6155.507559395238, 6207.937920620736, 6251.593646412968, 6102.6338419694075, 6122.0510820821955, 6128.540359473057, 6140.815775526741, 6157.199564056644, 6146.078088286793, 6147.047207682816, 6148.292946311142, 6166.969165154145, 6174.197354343906, 4778.426588809365, 4813.542713442217, 4857.587105096036, 4860.1008813369635, 4866.5376789205675, 4316.697831151852, 4409.713368631029, 4432.224360736923, 4435.379046933432, 4438.423005009393, 5637.830865074055, 5699.230603868507, 5699.572532060112, 5703.058995265817, 5727.656340619576, 6147.139400483936, 6148.9692551536955, 6150.569460137837, 6164.6917654118015, 6255.78104766331, 5660.179274005329, 5696.601237913306, 5720.599558030898, 5739.85650358736, 5745.597808153389, 5290.5238528531845, 5298.311219541435, 5301.0723123453245, 5305.840824775263, 5363.517283444508, 5411.918821217685, 6210.161628180138, 6222.844428889314, 6298.968505157445, 6338.968305158444, 6239.344868788893, 6242.0, 6259.467945224706, 6269.373062693694, 6271.0, 6196.752129914933, 6275.937240627535, 6297.307296197506, 6298.149749783721, 6302.527310451643, 6111.388861113853, 6140.017597184429, 6157.6613286269685, 6162.044883043135, 6177.505799536116, 6200.534959878118, 6235.220597425322, 6247.344028877084, 6254.593451425642, 6254.843628909313, 5877.441643043904, 5880.26496687914, 5977.9402205977385, 6071.969640151771, 6101.908471372844, 5943.138244954544, 5944.108383742473, 5948.464638182584, 5968.0, 5973.104034394702, 5812.593118481835, 5846.883062338815, 5848.619839710405, 5863.794767183128, 5873.73568189424, 5891.1457838614015, 5965.373635768182, 6084.452399284086, 6103.852895754643, 6121.051237058263, 5879.676617786063, 5884.0, 5887.470127688529, 5894.0, 5902.5277977762535], "unit": "score", "name": "dojo.html", "value": 5653.135128473111}, {"lowerIsBetter": false, "replicates": [454.9545045495453, 467.09150701884846, 496.48861672477364, 575.4446958684869, 611.6146827498675, 29040.709592904066, 29462.85268573657, 36771.89684309471, 37205.44191837118, 37362.252754944886, 39413.60586394135, 39775.00562485939, 39799.204015919735, 39820.60179398205, 40016.59983400165, 9376.062393760638, 9614.13472787449, 9635.470049147294, 9639.421634701905, 9643.276754243425, 9468.147866691996, 9610.903890961106, 9637.662681806138, 9643.132118109368, 9648.421094734304, 9667.033296670346, 9757.316987810857, 9772.364796288253, 9775.804483910317, 9788.314817962746, 9651.613935442574, 9719.805603887882, 9730.659426920023, 9733.853992190123, 9736.999999999965, 9528.428294302295, 9665.226781857435, 9683.806323873554, 9688.75778105546, 9691.70924872255, 37768.43347349792, 38216.61783382186, 38217.426738598944, 38301.425478617566, 38315.23369532594, 3071.692830716933, 3152.763542734304, 3183.3951549205576, 3322.9833850830832, 3530.5763308403157, 21818.563628727494, 27631.723682763117, 27707.445851083066, 27797.444051119066, 28217.858910705316, 2581.264339663187, 2612.71260161384, 2647.48374067057, 2661.2814540074264, 2693.851838148901, 471447.0, 473454.0, 473892.0, 474798.0, 475979.0, 42652.57347426486, 43341.13317733691, 43344.0, 43350.0, 43452.0, 42795.57204427978, 43010.13979720388, 43103.04315003752, 43105.56894431016, 43123.568764312586, 14919.627009324637, 15060.774088388684, 15090.622734431507, 15104.622384440478, 15106.471273505374, 10106.797864042825, 12173.634790956285, 12190.878091219152, 12211.145219834527, 12480.75038499243, 12669.923056540112, 13122.147060441232, 14063.578092657237, 14092.084014539023, 14114.294285285694, 6164.568480206342, 6231.937680623136, 6275.6548389839, 6275.717592708339, 6293.244810622663, 765.5215490318551, 876.5222953490363, 939.9707320484059, 956.3974695941652, 975.770693886936, 28139.0, 28664.71335286662, 28961.0, 28961.855190723913, 30025.04837185576, 874.6413970272285, 878.3587980774071, 923.1783712495884, 980.7548112971757, 1034.6136177522155, 13691.383887725076, 13704.794428083587, 13924.860751392356, 14067.507637232648, 14088.506902258372, 634499.0, 639654.0, 640118.0, 640417.0, 902641.0, 53793.92412151735, 54464.0, 54760.17859732107, 54830.177547336825, 54883.902321953334, 1438.0724432740824, 1461.7222727681706, 1476.933537990793, 1481.1631428243224, 1481.3926290220957, 23518.64722029137, 26805.0, 27711.30721731973, 29081.418371632026, 29904.25239369033, 48008.0, 48345.0, 49040.50959490502, 49058.0, 49076.01847963092, 440528.0, 445800.0, 446599.0, 447977.0, 448117.0, 25653.615195771705, 30819.69180308258, 31244.0, 31468.685313146576, 31527.054188374386, 31370.68629313769, 40453.59546404616, 40650.796746017266, 41610.37584436296, 41689.0, 32962.0, 34213.0, 34461.31077378388, 35041.824790876904, 35081.473777893865, 29096.0, 33732.49401258934, 34053.48919766156, 34778.30443391169, 34834.47748283727, 27480.450390992468, 29386.853065734533, 29712.702872970993, 34663.826680866434, 34882.16296207466, 27618.861905690344, 30290.545641815832, 30399.696003039688, 30589.694103058686, 32335.029949101565, 23940.521189575764, 24473.51052978895, 25474.363140921625, 25682.87158564195, 26124.216273511825], "unit": "score", "name": "ext.html", "value": 18240.341801055052}, {"lowerIsBetter": false, "replicates": [311.8362859498761, 358.8510768031267, 363.0904584017037, 367.7297186567872, 370.9128354836611, 16059.518214453556, 16574.66850662986, 19089.904550477244, 19273.614527709437, 21333.893330533345, 11933.940330298336, 11948.940255298712, 11959.342236177006, 11971.940140299286, 16306.50391474011, 5175.094358487268, 5194.870128246786, 5319.0957537218765, 5369.973150134244, 5377.704226267554, 3236.676332366768, 4097.549269580344, 4763.642726795487, 5399.0, 5408.945910540883, 4088.9591104088877, 4089.5501494835694, 4090.0797320602774, 5304.151335786275, 5935.228420305354, 5896.498797602209, 5902.085176797582, 5911.586188966774, 5919.993601087804, 5976.432238937294, 5435.157550579666, 5438.374586922476, 5441.0, 5445.284735308365, 5470.316210473691, 12976.091673582852, 13201.537946171933, 18624.068796560117, 24383.7561624385, 24399.0, 2056.23919149914, 2229.342344008521, 2319.420144963759, 2732.7130651281527, 2750.943003434974, 8342.916570834275, 9234.538273086386, 10103.393796372242, 11793.115516336224, 15044.623884402868, 1606.2771752711326, 1646.6706658668195, 1726.9050202238873, 1752.8518820172808, 1789.4899953513316, 102952.48523757333, 107612.4619376898, 107902.0, 113452.43273783661, 115450.26824597637, 9189.494577798285, 11019.0, 11274.774504509864, 11306.491207895664, 11314.208005439541, 13670.11144275619, 13698.246596437093, 13709.17744935307, 13719.176849388869, 13735.931320343334, 8398.454100483448, 8420.073791882887, 8450.577471126542, 8474.025487068942, 8556.871646925301, 8536.274416674529, 8542.487450752975, 8545.957270213608, 8627.482351058956, 8645.567721613894, 4469.307257375112, 4494.235979883428, 4501.437320334958, 4520.412346395014, 4549.886252843706, 1762.118940529735, 1853.8424233939998, 1886.9339573114876, 1896.473338962121, 1932.1401976120492, 835.4402550291198, 880.5729221327651, 965.792354643755, 976.8095221431895, 1000.9199264058858, 19313.015575173667, 19766.802331976498, 19809.20763169486, 19873.0, 19961.0, 751.3463286940397, 907.5190149220923, 922.3727865051695, 928.1924725488868, 963.9228861691048, 9740.707778766648, 10471.214658900613, 10536.894631053592, 10592.205584581186, 10648.254622176373, 494333.0, 505383.0, 507518.0, 559733.0, 638668.0, 72574.0, 119850.80149198396, 124000.37999810124, 127668.36165819112, 129467.35266323609, 1058.867641544807, 1062.914966802654, 1070.8768491623407, 1111.7109551516503, 1111.8888111188978, 14357.425702971765, 18021.63956720832, 18385.632287354445, 18442.538936526693, 18581.49149864805, 49540.0, 51105.74447127741, 52302.0, 52689.73655131853, 52730.73634631802, 71015.28984710293, 73721.0, 76010.0, 76464.61767691126, 76882.6155869217, 7756.961215193888, 7978.0, 8026.919730802617, 8033.277005069572, 8217.342612591097, 10749.408782517037, 13088.821243844039, 13256.602301930958, 13421.0, 13632.182069075887, 8027.719029833927, 11426.82859757121, 11508.712282193012, 11698.005669517846, 11814.586489472827, 10395.740106497398, 10962.081635713559, 11367.261128026652, 11580.536778529102, 11745.588904388305, 11360.46279672844, 11832.76334473323, 11840.407979601157, 11908.0, 12079.335636540074, 7911.723089691834, 8054.637541310538, 8075.83848323042, 8165.550894700848, 8267.83464330722, 11263.380514071805, 11581.247218930743, 11735.41322933867, 11747.412629368668, 11749.941250293694], "unit": "score", "name": "jquery.html", "value": 9055.646204187693}, {"lowerIsBetter": false, "replicates": [1370.7464119137953, 1502.7971223884776, 1509.856563626455, 1682.6802907447577, 1747.8951262924224, 7453.7763867084, 8390.748277551676, 8588.613512391941, 8607.526586037766, 8634.4387614805, 8368.0, 8587.52768597727, 8590.226879580836, 8605.225529702326, 8616.009158946723, 2404.134511575836, 2426.2721183644926, 2429.987850060756, 2435.3181109289426, 2436.025589764091, 2392.8085753139794, 2415.0, 2434.9391265218333, 2437.926862194137, 2458.9549441487384, 2417.6494408310787, 2439.2072576412647, 2444.877756112196, 2445.254197469771, 2447.3881529617597, 2407.41018450479, 2416.734159242482, 2433.0, 2434.817388695846, 2438.1710218525786, 2213.4577028627928, 2276.578832915916, 2372.9406764830846, 2425.2845410603913, 2432.8200822601025, 8646.005709343443, 8689.0, 8697.913020869773, 8700.390972631854, 8703.782405439915, 5285.339332583427, 5406.621536492447, 5412.0, 5420.756065977041, 5424.186372044185, 3455.827208639583, 3505.2463720300257, 3557.1818481749083, 3574.660407261306, 3583.372909740785, 990.5047476261869, 1012.71643939697, 1031.6750223679517, 1045.2839804733705, 1047.9056884880322, 11739.23694959825, 11745.0, 11745.11911606633, 11746.765064698659, 11753.706157346049, 4357.736256485584, 4644.674872758875, 4799.520047995243, 4839.516048395132, 4861.1979023460735, 8432.156784321518, 9025.41334813235, 9733.124018838196, 9909.554070066864, 9912.504374781376, 4829.396325459317, 5167.044096842021, 5374.220737992969, 5378.2470454136455, 5385.569154467712, 4341.479022517255, 4484.641228701696, 4692.061587682477, 4854.660173787801, 4932.605391568666, 3860.5560360558334, 3865.3042452358845, 3872.6514613684903, 3915.6084391561185, 3919.451276821247, 1254.6110705681267, 1283.786821453736, 1289.4970961325091, 1294.8769866862633, 1297.0, 945.2674177512483, 960.711786464058, 999.6051559633904, 1064.1593141418348, 1313.894888408925, 6915.377616014583, 7679.078510578766, 7887.645055972495, 7924.445288829842, 7936.047674279123, 1106.0709004436312, 1114.3035602748282, 1114.8327750837439, 1172.6130376975577, 1186.424584076722, 6073.331933487313, 6079.270487541523, 6109.877802443926, 6159.137720719103, 6159.876802464015, 10323.070923616911, 10605.734856628646, 10665.733356666145, 10681.679549613524, 10683.572657093784, 10348.844767328495, 10442.2168337375, 10459.529321180566, 10554.419506927039, 10555.155587552978, 7047.718091276394, 8144.267015968591, 8283.130271321425, 8309.293710034715, 8332.541710205996, 7670.539767613961, 7761.61191940412, 7777.4166937478785, 7804.921950780419, 7810.10183828867, 9244.630214791334, 9400.34197606161, 9419.85870211961, 9498.14516693501, 9601.903980960102, 8259.587020649064, 9450.43297402158, 9829.803403932025, 9848.261380396641, 9889.159421448969, 6570.11303474044, 6768.424683901727, 7035.261297563887, 7194.4244460442, 7275.417966562556, 7987.84024319522, 8026.197380261927, 8053.154418785943, 8054.758357249292, 8085.63614637331, 7054.576725396492, 7183.0, 7214.783556493314, 7280.745173918887, 7354.852902941804, 6823.829404264933, 6958.373746362851, 7012.123484564429, 7022.08712867324, 7200.243974382614, 7367.852642947004, 7599.088109426683, 7607.0, 7628.160902300631, 7630.313271805564, 6820.3861652451515, 6936.167659880846, 6937.993990871396, 6943.27095654949, 6948.235694073749, 6936.930630693629, 6992.965035174995, 7003.4747393944635, 7007.264237255014, 7008.229094799466], "unit": "score", "name": "mootools.html", "value": 4806.948910307711}, {"lowerIsBetter": false, "replicates": [319.0778649702361, 323.7232166497644, 329.2066120649236, 331.2348475022699, 334.0529598588004, 5709.971450142749, 6295.866743986081, 6584.2098948126295, 6612.173478315211, 6629.436497897673, 6512.772052978146, 6514.80455586332, 6516.576422532544, 6519.543631945754, 6531.2489063757685, 4886.022795440917, 4900.289458028602, 4906.1168989581865, 4917.385326834145, 4929.950700493003, 4923.729194894279, 4924.291639598225, 4933.136701077315, 4938.3086367908345, 4945.480724523927, 3937.5865534118934, 4395.714278571899, 4544.795484203219, 4616.33063205835, 4790.9520904791025, 4786.1863483207935, 4789.568938795508, 4794.7842347094465, 4797.112534181153, 4842.878928026792, 4168.583141685837, 4169.895752606179, 4174.186033723425, 4175.457190565237, 4185.518665353493, 6072.36240194782, 6125.785597504066, 6296.811095667137, 6302.401271879165, 6310.179676642053, 5608.859778505529, 5613.298337707786, 5617.4382561743905, 5631.352394474647, 5633.40849210831, 6910.550814197061, 6933.895991560131, 6935.375816176568, 6940.444764418834, 6941.72233110675, 4620.075984803019, 4620.561046700558, 4627.583517483409, 4629.23617603095, 4632.814687412533, 6961.477889158283, 7315.743948961814, 7343.559386436831, 7351.44864135192, 7358.190599034102, 4690.906181876343, 4748.833790817304, 4751.3348131261655, 4757.286407038971, 4764.404449443819, 4813.229883218668, 4820.25286080658, 4834.347363105936, 4835.685680430831, 4838.080764654705, 5600.663960162403, 5623.718814059281, 5636.0, 5642.351129620146, 5653.575981801381, 6006.399360064046, 6572.277049524549, 6934.618595977269, 6941.861162776817, 6968.233494315621, 1666.125284225767, 1687.190148728617, 1688.1727953302793, 1693.381915600797, 1693.449628870622, 871.8430682477215, 1001.8246806808779, 1026.0765311219814, 1051.8685164354456, 1052.315994603514, 6503.902441463382, 6571.704273307712, 6573.408393244536, 6575.572587781779, 6586.110875031905, 7015.719371225094, 7181.461390395742, 7192.856142877114, 7203.567785932861, 7232.20445750967, 6651.63416012124, 6657.933420665829, 6661.467082633378, 6661.833454163588, 6662.167229096363, 3836.8081595920094, 3870.3420418528917, 3870.9612903871166, 3873.7288389812443, 3879.631435013669, 7548.811279718051, 7549.698012079565, 7554.546727196386, 7575.128860181149, 7585.962070189614, 6587.769428070091, 6590.077389165521, 6945.791626251221, 7161.89257161143, 7420.0, 6950.165980082423, 7478.597238256581, 7533.660985255677, 7621.657025433758, 7668.923310766821, 7326.487145899736, 7334.193238743841, 7340.486165968331, 7340.669669864762, 7356.816079598053, 7176.569405835667, 7180.210176880643, 7180.461465390221, 7184.317489838457, 7191.820204494929, 5831.7667293307795, 7469.514481558681, 7506.549607023596, 7540.17058123595, 7594.240575942362, 4566.383538222298, 4583.427071616048, 4617.861464156081, 4619.099275641218, 4624.213883639856, 7200.243974382614, 7208.243134471015, 7212.4590655699985, 7215.422766178798, 7236.167840698387, 5721.685307308138, 7024.719011239493, 7043.154821421463, 7050.894236586558, 7056.188538317954, 6662.533622646368, 6964.582125072512, 6965.373116419547, 6977.232504424408, 6996.755113571001, 6834.760783372558, 6853.520253582202, 6868.0, 6877.6217308048535, 6896.862062758817, 5778.27771528559, 7033.964830175816, 7041.471889608198, 7041.647917604202, 7045.542039767399, 5213.921791173059, 6683.663267346453, 6870.828229294308, 6875.7937261882225, 6886.8622627548175], "unit": "score", "name": "prototype.html", "value": 5099.549844794721}, {"lowerIsBetter": false, "replicates": [629.7921685843672, 637.5600835423558, 642.2389468479848, 642.4763817488749, 688.6866475753533, 13863.445462181513, 14093.647658808522, 14109.929450352747, 14126.43494260231, 14139.08095973761, 13303.667408314797, 13486.46054157835, 13495.987800914922, 13497.662558436044, 13519.121257118304, 696.14721965592, 709.3474003916383, 847.8431490174322, 856.0968178571604, 874.3442418186361, 850.6894983331101, 855.9871601925976, 858.9527575983318, 861.7974775927684, 864.1229152410277, 737.4321772235376, 914.5244472874135, 915.1169121797465, 915.748169253454, 917.7338571814166, 898.2634239923266, 911.3802614222326, 913.2328843771197, 913.2739472119681, 913.9405938613969, 674.6390680985699, 675.8513127112027, 675.8783418984581, 676.8578598494322, 679.6092246957969, 14049.859501404957, 14136.010479266455, 14142.434302627986, 14146.08050476726, 14171.78742318866, 12365.31990740509, 12500.249985000839, 12582.24506529611, 12623.431945562379, 12802.80795788064, 9936.105750482491, 9988.1510071644, 10079.59681612742, 10124.392536447836, 10688.519016644192, 3146.11908665574, 3155.3689262147664, 3177.4757165067736, 3218.4206842768294, 3230.7415406767404, 69423.61152776967, 69532.652336738, 75300.62349688272, 79502.0, 79932.60033699853, 8135.552544609985, 9461.385009974467, 9471.47906865129, 9484.95257523708, 9521.952390238004, 20443.59112817735, 20643.277485288243, 20704.58590828175, 21666.133354665635, 21669.241576544744, 7356.742514011984, 7484.962575187089, 7533.849323013509, 7621.0, 7662.118856331482, 3970.7220494565104, 4019.577944315863, 4026.1142548639255, 4032.9917520619847, 4036.29364861154, 3508.7017603503477, 3540.185757275841, 3548.733844961638, 3550.591681956608, 3552.5381700379303, 574.5030548575536, 635.5836926812945, 644.5713600455645, 645.2128403347908, 667.1260648550415, 574.2620732358982, 602.9095635654687, 610.0452791381474, 622.7477871462065, 627.7834147219202, 8168.428210025241, 8357.874631880526, 8505.23452889243, 8533.914660853312, 8585.871211931826, 472.98868488365713, 545.7625932719279, 559.4182050667342, 608.2275510102146, 609.2171559546051, 3877.941830872539, 3899.863504777319, 4024.9798751006056, 4027.9798601006805, 4082.510098788164, 82164.58917705373, 83621.74567381495, 83985.0, 84178.0, 84272.73590896142, 83106.0, 83451.5827420859, 83896.58051709825, 84058.5797071023, 84769.57615211884, 74114.14714632177, 74773.13067173255, 74865.0, 74965.50068998699, 75540.0, 7714.884276735966, 7770.339521140766, 7922.128565857636, 8069.435139540175, 8112.269895709414, 50465.74767126141, 51457.742711286206, 52102.478975209764, 52753.20870186874, 53227.0, 65717.34282657113, 67593.6481270362, 72085.0, 72138.91791623234, 72940.0, 8288.005439347076, 9658.9034109658, 9739.41563506192, 9920.702378928643, 9985.700428987142, 9297.67458138962, 10754.0, 10853.131749460183, 11073.446327683423, 11612.767744645229, 10113.393196408239, 10349.586016559253, 10382.42896640692, 10460.476976151314, 10560.366378017343, 10282.640107596199, 10302.278840481395, 10306.381617102998, 10413.47932603382, 10566.418846963183, 10175.592976280866, 10286.948565257126, 10299.279050466695, 10401.739956501147, 10410.271281010257, 8565.229129378386, 8695.956520217358, 8872.778180545538, 8934.195922367018, 9086.045965173562, 8682.43564168327, 8740.388172827841, 8747.125287471203, 8853.911460885309, 8967.058458861726], "unit": "score", "name": "yui.html", "value": 6639.2657092468}], "name": "dromaeo_css", "value": 7305.209327588658}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 107.0, 110.0, 111.0, 111.0, 110.0, 115.0, 110.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 110.6}, {"lowerIsBetter": true, "replicates": [161.0, 119.0, 161.0, 189.0, 120.0, 145.0, 141.0, 122.0, 160.0, 120.0], "unit": "score", "name": "audio-beat-detection", "value": 143.8}, {"lowerIsBetter": true, "replicates": [185.0, 186.0, 187.0, 183.0, 186.0, 185.0, 187.0, 182.0, 179.0, 191.0], "unit": "score", "name": "audio-dft", "value": 185.1}, {"lowerIsBetter": true, "replicates": [77.0, 75.0, 85.0, 77.0, 56.0, 59.0, 57.0, 82.0, 76.0, 55.0], "unit": "score", "name": "audio-fft", "value": 69.9}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 129.0, 79.0, 80.0, 83.0, 112.0, 78.0, 79.0, 115.0], "unit": "score", "name": "audio-oscillator", "value": 94.0}, {"lowerIsBetter": true, "replicates": [84.0, 105.0, 131.0, 89.0, 84.0, 89.0, 83.0, 90.0, 84.0, 88.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 92.7}, {"lowerIsBetter": true, "replicates": [94.0, 92.0, 93.0, 92.0, 98.0, 93.0, 94.0, 92.0, 93.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 93.4}, {"lowerIsBetter": true, "replicates": [84.0, 86.0, 85.0, 86.0, 85.0, 88.0, 90.0, 87.0, 86.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 86.2}, {"lowerIsBetter": true, "replicates": [54.0, 53.0, 52.0, 52.0, 52.0, 52.0, 54.0, 65.0, 52.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 53.8}, {"lowerIsBetter": true, "replicates": [64.0, 70.0, 66.0, 73.0, 69.0, 67.0, 67.0, 67.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 83.0, 107.0, 84.0, 82.0, 82.0, 82.0, 84.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.5}, {"lowerIsBetter": true, "replicates": [124.0, 133.0, 124.0, 113.0, 138.0, 104.0, 124.0, 126.0, 125.0, 130.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.1}, {"lowerIsBetter": true, "replicates": [139.0, 127.0, 137.0, 138.0, 139.0, 126.0, 139.0, 129.0, 138.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 134.8}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 67.0, 67.0, 67.0, 66.0, 66.0, 66.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.8}], "name": "kraken", "value": 1408.4999999999998}]} 09:43:16 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1408.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7305.21"}}} 09:43:16 INFO - Return code: 0 09:43:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:43:16 INFO - # TBPL SUCCESS # 09:43:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:43:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:43:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:43:16 INFO - 2016-02-24 09:43:16.780 screenresolution[2001:13534] starting screenresolution argv=screenresolution get 09:43:16 INFO - 2016-02-24 09:43:16.782 screenresolution[2001:13534] Display 0: 1600x1200x32@60 09:43:16 INFO - 2016-02-24 09:43:16.788 screenresolution[2002:13537] starting screenresolution argv=screenresolution list 09:43:16 INFO - Available Modes on Display 0 09:43:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:43:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:43:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:43:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:43:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:43:17 INFO - Intel Iris: 09:43:17 INFO - Chipset Model: Intel Iris 09:43:17 INFO - Type: GPU 09:43:17 INFO - Bus: Built-In 09:43:17 INFO - VRAM (Dynamic, Max): 1536 MB 09:43:17 INFO - Vendor: Intel (0x8086) 09:43:17 INFO - Device ID: 0x0a2e 09:43:17 INFO - Revision ID: 0x0009 09:43:17 INFO - Displays: 09:43:17 INFO - Display: 09:43:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:43:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:43:17 INFO - Display Serial Number: 1600x1200 60 09:43:17 INFO - Main Display: Yes 09:43:17 INFO - Mirror: Off 09:43:17 INFO - Online: Yes 09:43:17 INFO - Rotation: Supported 09:43:17 INFO - Return code: 0 09:43:17 INFO - Running post-action listener: _resource_record_post_action 09:43:17 INFO - Running post-run listener: _resource_record_post_run 09:43:18 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 2564096; Write bytes: 705239040; Read time: 40; Write time: 1990 09:43:18 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 404009472; Write bytes: 406005760; Read time: 30163; Write time: 762 09:43:18 INFO - run-tests - Wall time: 1174s; CPU: 52.0%; Read bytes: 2527232; Write bytes: 297574400; Read time: 38; Write time: 1222 09:43:18 INFO - Running post-run listener: _upload_blobber_files 09:43:18 INFO - Blob upload gear active. 09:43:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:43:18 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 09:43:18 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'] 09:43:18 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 09:43:18 INFO - (blobuploader) - INFO - Open directory for files ... 09:43:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:43:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:43:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:43:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:43:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:43:19 INFO - (blobuploader) - INFO - Done attempting. 09:43:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:43:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:43:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:43:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:43:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:43:20 INFO - (blobuploader) - INFO - Done attempting. 09:43:20 INFO - (blobuploader) - INFO - Iteration through files over. 09:43:20 INFO - Return code: 0 09:43:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:43:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:43:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7a224b2123025840b7059522609eede49bcd3e4e8dbe625dfd9291a44a3b30662b748bae22404ece0c3cfc4473976400200b5605e3e5a7ec36ed49e40f8a3383", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/283e91c554d7b5c24d92cd2eee04ee9c5d22d4bcb6c0d797e46a73fa614bdb48867bb693d7fc1ceb9d29b74575eeca40ad89da27487b2e56743f8080e5e54180"} 09:43:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:43:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:43:20 INFO - Contents: 09:43:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7a224b2123025840b7059522609eede49bcd3e4e8dbe625dfd9291a44a3b30662b748bae22404ece0c3cfc4473976400200b5605e3e5a7ec36ed49e40f8a3383", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/283e91c554d7b5c24d92cd2eee04ee9c5d22d4bcb6c0d797e46a73fa614bdb48867bb693d7fc1ceb9d29b74575eeca40ad89da27487b2e56743f8080e5e54180"} 09:43:20 INFO - Running post-run listener: copy_logs_to_upload_dir 09:43:20 INFO - Copying logs to upload dir... 09:43:20 INFO - mkdir: /builds/slave/test/build/upload/logs 09:43:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.784286 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-02-24 09:43:20.214121) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-24 09:43:20.217247) ========= 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.z5r4gQeHn3/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.n8ooadwoVf/Listeners TMPDIR=/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/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/7a224b2123025840b7059522609eede49bcd3e4e8dbe625dfd9291a44a3b30662b748bae22404ece0c3cfc4473976400200b5605e3e5a7ec36ed49e40f8a3383", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/283e91c554d7b5c24d92cd2eee04ee9c5d22d4bcb6c0d797e46a73fa614bdb48867bb693d7fc1ceb9d29b74575eeca40ad89da27487b2e56743f8080e5e54180"} build_url:https://queue.taskcluster.net/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011164 build_url: 'https://queue.taskcluster.net/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7a224b2123025840b7059522609eede49bcd3e4e8dbe625dfd9291a44a3b30662b748bae22404ece0c3cfc4473976400200b5605e3e5a7ec36ed49e40f8a3383", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/283e91c554d7b5c24d92cd2eee04ee9c5d22d4bcb6c0d797e46a73fa614bdb48867bb693d7fc1ceb9d29b74575eeca40ad89da27487b2e56743f8080e5e54180"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-24 09:43:20.256547) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 09:43:20.256938) ========= 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.z5r4gQeHn3/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.n8ooadwoVf/Listeners TMPDIR=/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/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.005096 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 09:43:20.305977) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-24 09:43:20.306370) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-24 09:43:20.306798) ========= ========= Total master_lag: 1.88 =========