builder: fx-team_yosemite_test-dromaeojs-e10s slave: t-yosemite-r5-0097 starttime: 1446730518.13 results: success (0) buildid: 20151105031836 builduid: 318da402561d4e02899c3c974351779a revision: bad16f7ef2ce7b0d2e87c384dd0cf9ef314156f5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-05 05:35:18.129770) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-05 05:35:18.130198) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-05 05:35:18.130511) ========= 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.GNVMHtXvPt/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.2m2FLfLJYQ/Listeners TMPDIR=/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/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:0x0:0x0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006041 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-05 05:35:18.188915) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-05 05:35:18.189220) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-05 05:35:18.210465) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 05:35:18.210769) ========= 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.GNVMHtXvPt/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.2m2FLfLJYQ/Listeners TMPDIR=/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/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:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.022881 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 05:35:18.260069) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-05 05:35:18.260357) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-05 05:35:18.260812) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 05:35:18.261100) ========= 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.GNVMHtXvPt/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.2m2FLfLJYQ/Listeners TMPDIR=/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/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:0x0:0x0 using PTY: False --2015-11-05 05:35:18-- 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% 1.41G=0s 2015-11-05 05:35:18 (1.41 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.173196 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 05:35:18.449359) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 05:35:18.449698) ========= 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.GNVMHtXvPt/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.2m2FLfLJYQ/Listeners TMPDIR=/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/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:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.134140 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 05:35:18.598362) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 05:35:18.598732) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev bad16f7ef2ce7b0d2e87c384dd0cf9ef314156f5 --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 bad16f7ef2ce7b0d2e87c384dd0cf9ef314156f5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.GNVMHtXvPt/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.2m2FLfLJYQ/Listeners TMPDIR=/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/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:0x0:0x0 using PTY: False 2015-11-05 05:35:18,684 truncating revision to first 12 chars 2015-11-05 05:35:18,684 Setting DEBUG logging. 2015-11-05 05:35:18,684 attempt 1/10 2015-11-05 05:35:18,684 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/bad16f7ef2ce?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-05 05:35:18,934 unpacking tar archive at: fx-team-bad16f7ef2ce/testing/mozharness/ program finished with exit code 0 elapsedTime=0.538013 ========= master_lag: 0.18 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 05:35:19.316098) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-05 05:35:19.316411) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-05 05:35:19.329511) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-05 05:35:19.329780) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-05 05:35:19.330149) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 44 secs) (at 2015-11-05 05:35:19.330454) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--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.GNVMHtXvPt/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.2m2FLfLJYQ/Listeners TMPDIR=/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/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:0x0:0x0 using PTY: False 05:35:19 INFO - MultiFileLogger online at 20151105 05:35:19 in /builds/slave/test 05:35:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:35:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:35:19 INFO - {'append_to_log': False, 05:35:19 INFO - 'base_work_dir': '/builds/slave/test', 05:35:19 INFO - 'blob_upload_branch': 'Fx-Team', 05:35:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:35:19 INFO - 'branch': 'Fx-Team', 05:35:19 INFO - 'buildbot_json_path': 'buildprops.json', 05:35:19 INFO - 'config_files': ('talos/mac_config.py',), 05:35:19 INFO - 'default_actions': ('clobber', 05:35:19 INFO - 'read-buildbot-config', 05:35:19 INFO - 'download-and-extract', 05:35:19 INFO - 'populate-webroot', 05:35:19 INFO - 'create-virtualenv', 05:35:19 INFO - 'install', 05:35:19 INFO - 'run-tests'), 05:35:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:35:19 INFO - 'download_minidump_stackwalk': True, 05:35:19 INFO - 'download_symbols': 'ondemand', 05:35:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:35:19 INFO - 'tooltool.py': '/tools/tooltool.py', 05:35:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:35:19 INFO - '/tools/misc-python/virtualenv.py')}, 05:35:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:35:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:35:19 INFO - 'installer_path': 'installer.exe', 05:35:19 INFO - 'log_level': 'info', 05:35:19 INFO - 'log_name': 'talos', 05:35:19 INFO - 'log_to_console': True, 05:35:19 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:35:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:35:19 INFO - 'opt_config_files': (), 05:35:19 INFO - 'pip_index': False, 05:35:19 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:35:19 INFO - 'cmd': ('bash', 05:35:19 INFO - '-c', 05:35:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:35:19 INFO - 'enabled': True, 05:35:19 INFO - 'halt_on_failure': False, 05:35:19 INFO - 'name': 'check_screen_resolution'},), 05:35:19 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:35:19 INFO - 'cmd': ('bash', 05:35:19 INFO - '-c', 05:35:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:35:19 INFO - 'enabled': True, 05:35:19 INFO - 'halt_on_failure': False, 05:35:19 INFO - 'name': 'check_screen_resolution'},), 05:35:19 INFO - 'run_cmd_checks_enabled': True, 05:35:19 INFO - 'sps_profile': False, 05:35:19 INFO - 'sps_profile_interval': 0, 05:35:19 INFO - 'suite': 'dromaeojs-e10s', 05:35:19 INFO - 'system_bits': '64', 05:35:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:35:19 INFO - 'title': 't-yosemite-r5-0097', 05:35:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:35:19 INFO - 'use_talos_json': True, 05:35:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:35:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:35:19 INFO - 'work_dir': 'build'} 05:35:19 INFO - ##### 05:35:19 INFO - ##### Running clobber step. 05:35:19 INFO - ##### 05:35:19 INFO - Running pre-action listener: _resource_record_pre_action 05:35:19 INFO - Running main action method: clobber 05:35:19 INFO - rmtree: /builds/slave/test/build 05:35:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:35:24 INFO - Running post-action listener: _resource_record_post_action 05:35:24 INFO - ##### 05:35:24 INFO - ##### Running read-buildbot-config step. 05:35:24 INFO - ##### 05:35:24 INFO - Running pre-action listener: _resource_record_pre_action 05:35:24 INFO - Running main action method: read_buildbot_config 05:35:24 INFO - Using buildbot properties: 05:35:24 INFO - { 05:35:24 INFO - "properties": { 05:35:24 INFO - "buildnumber": 13, 05:35:24 INFO - "product": "firefox", 05:35:24 INFO - "script_repo_revision": "production", 05:35:24 INFO - "builddir": "fx-team_yosemite_test-dromaeojs-e10s", 05:35:24 INFO - "repository": "", 05:35:24 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 fx-team talos dromaeojs-e10s", 05:35:24 INFO - "buildid": "20151105031836", 05:35:24 INFO - "slavename": "t-yosemite-r5-0097", 05:35:24 INFO - "pgo_build": "False", 05:35:24 INFO - "basedir": "/builds/slave/test", 05:35:24 INFO - "project": "", 05:35:24 INFO - "platform": "yosemite", 05:35:24 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 05:35:24 INFO - "slavebuilddir": "test", 05:35:24 INFO - "scheduler": "tests-fx-team-macosx64-talos", 05:35:24 INFO - "branch": "fx-team", 05:35:24 INFO - "repo_path": "integration/fx-team", 05:35:24 INFO - "stage_platform": "macosx64", 05:35:24 INFO - "builduid": "318da402561d4e02899c3c974351779a", 05:35:24 INFO - "revision": "bad16f7ef2ce7b0d2e87c384dd0cf9ef314156f5" 05:35:24 INFO - }, 05:35:24 INFO - "sourcestamp": { 05:35:24 INFO - "repository": "", 05:35:24 INFO - "hasPatch": false, 05:35:24 INFO - "project": "", 05:35:24 INFO - "branch": "fx-team-macosx64-talos", 05:35:24 INFO - "changes": [ 05:35:24 INFO - { 05:35:24 INFO - "category": null, 05:35:24 INFO - "files": [ 05:35:24 INFO - { 05:35:24 INFO - "url": null, 05:35:24 INFO - "name": "https://queue.taskcluster.net/v1/task/4HLF7bZtSW-wpSI8QhQYsg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 05:35:24 INFO - } 05:35:24 INFO - ], 05:35:24 INFO - "repository": "", 05:35:24 INFO - "rev": "bad16f7ef2ce7b0d2e87c384dd0cf9ef314156f5", 05:35:24 INFO - "who": "cbook@mozilla.com", 05:35:24 INFO - "when": 1446730297, 05:35:24 INFO - "number": 6625144, 05:35:24 INFO - "comments": "Merge mozilla-central to fx-team", 05:35:24 INFO - "project": "", 05:35:24 INFO - "at": "Thu 05 Nov 2015 05:31:37", 05:35:24 INFO - "branch": "fx-team-macosx64-talos", 05:35:24 INFO - "revlink": "", 05:35:24 INFO - "properties": [ 05:35:24 INFO - [ 05:35:24 INFO - "buildid", 05:35:24 INFO - "20151105031836", 05:35:24 INFO - "Change" 05:35:24 INFO - ], 05:35:24 INFO - [ 05:35:24 INFO - "builduid", 05:35:24 INFO - "318da402561d4e02899c3c974351779a", 05:35:24 INFO - "Change" 05:35:24 INFO - ], 05:35:24 INFO - [ 05:35:24 INFO - "pgo_build", 05:35:24 INFO - "False", 05:35:24 INFO - "Change" 05:35:24 INFO - ] 05:35:24 INFO - ], 05:35:24 INFO - "revision": "bad16f7ef2ce7b0d2e87c384dd0cf9ef314156f5" 05:35:24 INFO - } 05:35:24 INFO - ], 05:35:24 INFO - "revision": "bad16f7ef2ce7b0d2e87c384dd0cf9ef314156f5" 05:35:24 INFO - } 05:35:24 INFO - } 05:35:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/4HLF7bZtSW-wpSI8QhQYsg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 05:35:24 INFO - Running post-action listener: _resource_record_post_action 05:35:24 INFO - ##### 05:35:24 INFO - ##### Running download-and-extract step. 05:35:24 INFO - ##### 05:35:24 INFO - Running pre-action listener: _resource_record_pre_action 05:35:24 INFO - Running main action method: download_and_extract 05:35:24 INFO - mkdir: /builds/slave/test/build/tests 05:35:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:24 INFO - https://queue.taskcluster.net/v1/task/4HLF7bZtSW-wpSI8QhQYsg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:35:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HLF7bZtSW-wpSI8QhQYsg/artifacts/public/build/test_packages.json 05:35:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HLF7bZtSW-wpSI8QhQYsg/artifacts/public/build/test_packages.json 05:35:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HLF7bZtSW-wpSI8QhQYsg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:35:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HLF7bZtSW-wpSI8QhQYsg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:35:25 INFO - Downloaded 1149 bytes. 05:35:25 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:35:25 INFO - Using the following test package requirements: 05:35:25 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:35:25 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:35:25 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 05:35:25 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:35:25 INFO - u'jsshell-mac.zip'], 05:35:25 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:35:25 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 05:35:25 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:35:25 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:35:25 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 05:35:25 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:35:25 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 05:35:25 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:35:25 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 05:35:25 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:35:25 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:35:25 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 05:35:25 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:35:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:25 INFO - https://queue.taskcluster.net/v1/task/4HLF7bZtSW-wpSI8QhQYsg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:35:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HLF7bZtSW-wpSI8QhQYsg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:35:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HLF7bZtSW-wpSI8QhQYsg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:35:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HLF7bZtSW-wpSI8QhQYsg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:35:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HLF7bZtSW-wpSI8QhQYsg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:35:26 INFO - Downloaded 17458735 bytes. 05:35:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 05:35:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:35:26 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 05:35:31 INFO - Return code: 0 05:35:31 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip', u'firefox-45.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:35:31 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')]} 05:35:31 INFO - https://queue.taskcluster.net/v1/task/4HLF7bZtSW-wpSI8QhQYsg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:35:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HLF7bZtSW-wpSI8QhQYsg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:35:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HLF7bZtSW-wpSI8QhQYsg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:35:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HLF7bZtSW-wpSI8QhQYsg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:35:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HLF7bZtSW-wpSI8QhQYsg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:35:32 INFO - Downloaded 17458735 bytes. 05:35:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 05:35:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:35:32 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 05:35:37 INFO - Return code: 0 05:35:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:37 INFO - https://queue.taskcluster.net/v1/task/4HLF7bZtSW-wpSI8QhQYsg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:35:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HLF7bZtSW-wpSI8QhQYsg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:35:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HLF7bZtSW-wpSI8QhQYsg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:35:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HLF7bZtSW-wpSI8QhQYsg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:35:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HLF7bZtSW-wpSI8QhQYsg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:35:38 INFO - Downloaded 11131307 bytes. 05:35:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 05:35:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:35:38 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 05:35:39 INFO - Return code: 0 05:35: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')]} 05:35:39 INFO - https://queue.taskcluster.net/v1/task/4HLF7bZtSW-wpSI8QhQYsg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:35:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HLF7bZtSW-wpSI8QhQYsg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:35:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HLF7bZtSW-wpSI8QhQYsg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:35:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HLF7bZtSW-wpSI8QhQYsg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 05:35:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HLF7bZtSW-wpSI8QhQYsg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg'}, attempt #1 05:35:42 INFO - Downloaded 108678597 bytes. 05:35:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/4HLF7bZtSW-wpSI8QhQYsg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:35:42 INFO - mkdir: /builds/slave/test/properties 05:35:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:35:42 INFO - Writing to file /builds/slave/test/properties/build_url 05:35:42 INFO - Contents: 05:35:42 INFO - build_url:https://queue.taskcluster.net/v1/task/4HLF7bZtSW-wpSI8QhQYsg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:35:42 INFO - Running post-action listener: _resource_record_post_action 05:35:42 INFO - Running post-action listener: set_extra_try_arguments 05:35:42 INFO - ##### 05:35:42 INFO - ##### Running populate-webroot step. 05:35:42 INFO - ##### 05:35:42 INFO - Running pre-action listener: _resource_record_pre_action 05:35:42 INFO - Running main action method: populate_webroot 05:35:42 INFO - Guessing talos json url... 05:35:42 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')]} 05:35:42 INFO - https://queue.taskcluster.net/v1/task/4HLF7bZtSW-wpSI8QhQYsg/artifacts/public/build/firefox-45.0a1.en-US.mac.txt matches https://queue.taskcluster.net 05:35:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HLF7bZtSW-wpSI8QhQYsg/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 05:35:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HLF7bZtSW-wpSI8QhQYsg/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 05:35:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HLF7bZtSW-wpSI8QhQYsg/artifacts/public/build/firefox-45.0a1.en-US.mac.txt to /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 05:35:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HLF7bZtSW-wpSI8QhQYsg/artifacts/public/build/firefox-45.0a1.en-US.mac.txt', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.txt'}, attempt #1 05:35:42 INFO - Downloaded 103 bytes. 05:35:42 INFO - Reading from file /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 05:35:42 INFO - Contents: 05:35:42 INFO - 20151105031836 05:35:42 INFO - https://hg.mozilla.org/integration/fx-team/rev/bad16f7ef2ce7b0d2e87c384dd0cf9ef314156f5 05:35:42 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')]} 05:35:42 INFO - trying https://hg.mozilla.org/integration/fx-team/raw-file/bad16f7ef2/testing/talos/talos.json 05:35:42 INFO - Downloading https://hg.mozilla.org/integration/fx-team/raw-file/bad16f7ef2/testing/talos/talos.json to /builds/slave/test/build/talos.json 05:35:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/integration/fx-team/raw-file/bad16f7ef2/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 05:35:43 INFO - Downloaded 4264 bytes. 05:35:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:35:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:35:43 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 05:35:43 INFO - '../fennec_ids.txt'], 05:35:43 INFO - 'tests': ['tcheck2']}, 05:35:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:35:43 INFO - '--tppagecycles', 05:35:43 INFO - '7'], 05:35:43 INFO - 'tests': ['tsvgm']}}, 05:35:43 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:35:43 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:35:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:35:43 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:35:43 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:35:43 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:35:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:35:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:43 INFO - 'talos_options': ['--e10s'], 05:35:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:35:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:43 INFO - 'tests': ['damp', 'tps']}, 05:35:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:43 INFO - 'talos_options': ['--e10s'], 05:35:43 INFO - 'tests': ['damp', 'tps']}, 05:35:43 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:35:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:35:43 INFO - 'other': {'tests': ['a11yr', 05:35:43 INFO - 'ts_paint', 05:35:43 INFO - 'tpaint', 05:35:43 INFO - 'sessionrestore', 05:35:43 INFO - 'sessionrestore_no_auto_restore']}, 05:35:43 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:35:43 INFO - 'tests': ['a11yr', 05:35:43 INFO - 'ts_paint', 05:35:43 INFO - 'tpaint', 05:35:43 INFO - 'sessionrestore', 05:35:43 INFO - 'sessionrestore_no_auto_restore']}, 05:35:43 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:35:43 INFO - 'tests': ['a11yr', 05:35:43 INFO - 'ts_paint', 05:35:43 INFO - 'tpaint', 05:35:43 INFO - 'sessionrestore', 05:35:43 INFO - 'sessionrestore_no_auto_restore']}, 05:35:43 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:35:43 INFO - 'tests': ['a11yr', 05:35:43 INFO - 'ts_paint', 05:35:43 INFO - 'tpaint', 05:35:43 INFO - 'sessionrestore', 05:35:43 INFO - 'sessionrestore_no_auto_restore']}, 05:35:43 INFO - 'other_l64': {'tests': ['a11yr', 05:35:43 INFO - 'ts_paint', 05:35:43 INFO - 'tpaint', 05:35:43 INFO - 'sessionrestore', 05:35:43 INFO - 'sessionrestore_no_auto_restore']}, 05:35:43 INFO - 'other_nol64': {'tests': ['a11yr', 05:35:43 INFO - 'ts_paint', 05:35:43 INFO - 'tpaint', 05:35:43 INFO - 'sessionrestore', 05:35:43 INFO - 'sessionrestore_no_auto_restore']}, 05:35:43 INFO - 'svgr': {'tests': ['tsvgx', 05:35:43 INFO - 'tsvgr_opacity', 05:35:43 INFO - 'tart', 05:35:43 INFO - 'tscrollx', 05:35:43 INFO - 'cart']}, 05:35:43 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:35:43 INFO - 'tests': ['tsvgx', 05:35:43 INFO - 'tsvgr_opacity', 05:35:43 INFO - 'tart', 05:35:43 INFO - 'tscrollx', 05:35:43 INFO - 'cart']}, 05:35:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:43 INFO - 'tests': ['tp5o']}, 05:35:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:43 INFO - 'talos_options': ['--e10s'], 05:35:43 INFO - 'tests': ['tp5o']}, 05:35:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:43 INFO - 'talos_options': ['--xperf_path', 05:35:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:35:43 INFO - 'tests': ['tp5n']}, 05:35:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:43 INFO - 'talos_options': ['--e10s', 05:35:43 INFO - '--xperf_path', 05:35:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 05:35:43 INFO - 'C:/slave/talos-data/talos/xperf.config'], 05:35:43 INFO - 'tests': ['tp5n']}}, 05:35:43 INFO - 'talos.zip': {'path': '', 05:35:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:35:43 INFO - Running post-action listener: _resource_record_post_action 05:35:43 INFO - ##### 05:35:43 INFO - ##### Running create-virtualenv step. 05:35:43 INFO - ##### 05:35:43 INFO - Running pre-action listener: _resource_record_pre_action 05:35:43 INFO - Running main action method: create_virtualenv 05:35:43 INFO - Creating virtualenv /builds/slave/test/build/venv 05:35:43 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:35:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:35:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:35:43 INFO - Using real prefix '/tools/python27' 05:35:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:35:44 INFO - Installing distribute.............................................................................................................................................................................................done. 05:35:47 INFO - Installing pip.................done. 05:35:47 INFO - Return code: 0 05:35:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:35:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10b18ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1f9228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe01f2e680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1419f0>, '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 0x10aea0cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b10b990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GNVMHtXvPt/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.2m2FLfLJYQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:35:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 05:35:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 05:35:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GNVMHtXvPt/Render', 05:35:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:35:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:35:47 INFO - 'HOME': '/Users/cltbld', 05:35:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:35:47 INFO - 'LOGNAME': 'cltbld', 05:35:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:47 INFO - 'MOZ_NO_REMOTE': '1', 05:35:47 INFO - 'NO_EM_RESTART': '1', 05:35:47 INFO - 'PAGER': '/bin/cat', 05:35:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:35:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:47 INFO - 'PWD': '/builds/slave/test', 05:35:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:35:47 INFO - 'SHELL': '/bin/bash', 05:35:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2m2FLfLJYQ/Listeners', 05:35:47 INFO - 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/', 05:35:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:35:47 INFO - 'USER': 'cltbld', 05:35:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:35:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:35:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:47 INFO - 'XPC_FLAGS': '0x0', 05:35:47 INFO - 'XPC_SERVICE_NAME': '0', 05:35:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:35:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:48 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 05:35:48 INFO - Cleaning up... 05:35:48 INFO - Return code: 0 05:35:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:35:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10b18ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1f9228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe01f2e680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1419f0>, '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 0x10aea0cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b10b990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GNVMHtXvPt/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.2m2FLfLJYQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:35:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 05:35:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 05:35:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GNVMHtXvPt/Render', 05:35:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:35:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:35:48 INFO - 'HOME': '/Users/cltbld', 05:35:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:35:48 INFO - 'LOGNAME': 'cltbld', 05:35:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:48 INFO - 'MOZ_NO_REMOTE': '1', 05:35:48 INFO - 'NO_EM_RESTART': '1', 05:35:48 INFO - 'PAGER': '/bin/cat', 05:35:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:35:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:48 INFO - 'PWD': '/builds/slave/test', 05:35:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:35:48 INFO - 'SHELL': '/bin/bash', 05:35:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2m2FLfLJYQ/Listeners', 05:35:48 INFO - 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/', 05:35:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:35:48 INFO - 'USER': 'cltbld', 05:35:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:35:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:35:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:48 INFO - 'XPC_FLAGS': '0x0', 05:35:48 INFO - 'XPC_SERVICE_NAME': '0', 05:35:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:35:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:48 INFO - Downloading/unpacking psutil>=0.7.1 05:35:48 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 05:35:48 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 05:35:48 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 05:35:48 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 05:35:48 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 05:35:48 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 05:35:51 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 05:35:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:35:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:35:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:35:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:35:51 INFO - Installing collected packages: psutil 05:35:51 INFO - Running setup.py install for psutil 05:35:51 INFO - building 'psutil._psutil_osx' extension 05:35:51 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:35:53 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 05:35:53 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 05:35:53 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 05:35:54 INFO - building 'psutil._psutil_posix' extension 05:35:54 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 05:35:54 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:35:54 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:35:54 INFO - ^ 05:35:54 INFO - 1 warning generated. 05:35:54 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 05:35:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:35:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:35:54 INFO - Successfully installed psutil 05:35:54 INFO - Cleaning up... 05:35:54 INFO - Return code: 0 05:35:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:35:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10b18ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1f9228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe01f2e680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1419f0>, '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 0x10aea0cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b10b990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GNVMHtXvPt/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.2m2FLfLJYQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:35:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 05:35:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 05:35:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GNVMHtXvPt/Render', 05:35:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:35:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:35:54 INFO - 'HOME': '/Users/cltbld', 05:35:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:35:54 INFO - 'LOGNAME': 'cltbld', 05:35:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:54 INFO - 'MOZ_NO_REMOTE': '1', 05:35:54 INFO - 'NO_EM_RESTART': '1', 05:35:54 INFO - 'PAGER': '/bin/cat', 05:35:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:35:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:54 INFO - 'PWD': '/builds/slave/test', 05:35:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:35:54 INFO - 'SHELL': '/bin/bash', 05:35:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2m2FLfLJYQ/Listeners', 05:35:54 INFO - 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/', 05:35:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:35:54 INFO - 'USER': 'cltbld', 05:35:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:35:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:35:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:54 INFO - 'XPC_FLAGS': '0x0', 05:35:54 INFO - 'XPC_SERVICE_NAME': '0', 05:35:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:35:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:35:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:35:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:35:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:35:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:35:57 INFO - Installing collected packages: mozsystemmonitor 05:35:57 INFO - Running setup.py install for mozsystemmonitor 05:35:57 INFO - Successfully installed mozsystemmonitor 05:35:57 INFO - Cleaning up... 05:35:57 INFO - Return code: 0 05:35:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:35:57 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')]} 05:35:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:57 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')]} 05:35:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10b18ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1f9228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe01f2e680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1419f0>, '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 0x10aea0cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b10b990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GNVMHtXvPt/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.2m2FLfLJYQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:35:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 05:35:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 05:35:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GNVMHtXvPt/Render', 05:35:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:35:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:35:57 INFO - 'HOME': '/Users/cltbld', 05:35:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:35:57 INFO - 'LOGNAME': 'cltbld', 05:35:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:57 INFO - 'MOZ_NO_REMOTE': '1', 05:35:57 INFO - 'NO_EM_RESTART': '1', 05:35:57 INFO - 'PAGER': '/bin/cat', 05:35:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:35:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:57 INFO - 'PWD': '/builds/slave/test', 05:35:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:35:57 INFO - 'SHELL': '/bin/bash', 05:35:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2m2FLfLJYQ/Listeners', 05:35:57 INFO - 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/', 05:35:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:35:57 INFO - 'USER': 'cltbld', 05:35:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:35:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:35:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:57 INFO - 'XPC_FLAGS': '0x0', 05:35:57 INFO - 'XPC_SERVICE_NAME': '0', 05:35:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:35:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:57 INFO - Downloading/unpacking blobuploader==1.2.4 05:35: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 05:35: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 05:35: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 05:35: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 05:35: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 05:35: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 05:36:00 INFO - Downloading blobuploader-1.2.4.tar.gz 05:36:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:36:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:36:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:36:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:36:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:36:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:36: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 05:36: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 05:36: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 05:36: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 05:36: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 05:36: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 05:36:01 INFO - Downloading docopt-0.6.1.tar.gz 05:36:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:36:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:36:01 INFO - Installing collected packages: blobuploader, requests, docopt 05:36:01 INFO - Running setup.py install for blobuploader 05:36:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:36:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:36:01 INFO - Running setup.py install for requests 05:36:02 INFO - Running setup.py install for docopt 05:36:02 INFO - Successfully installed blobuploader requests docopt 05:36:02 INFO - Cleaning up... 05:36:02 INFO - Return code: 0 05:36:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:36:02 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')]} 05:36:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:02 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')]} 05:36:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10b18ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1f9228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe01f2e680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1419f0>, '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 0x10aea0cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b10b990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GNVMHtXvPt/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.2m2FLfLJYQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:36:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 05:36:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --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 05:36:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GNVMHtXvPt/Render', 05:36:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:02 INFO - 'HOME': '/Users/cltbld', 05:36:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:02 INFO - 'LOGNAME': 'cltbld', 05:36:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:02 INFO - 'MOZ_NO_REMOTE': '1', 05:36:02 INFO - 'NO_EM_RESTART': '1', 05:36:02 INFO - 'PAGER': '/bin/cat', 05:36:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:02 INFO - 'PWD': '/builds/slave/test', 05:36:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:02 INFO - 'SHELL': '/bin/bash', 05:36:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2m2FLfLJYQ/Listeners', 05:36:02 INFO - 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/', 05:36:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:02 INFO - 'USER': 'cltbld', 05:36:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:02 INFO - 'XPC_FLAGS': '0x0', 05:36:02 INFO - 'XPC_SERVICE_NAME': '0', 05:36:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:36:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:36:02 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-_hXIS7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:36:03 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-j6kOU_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:36:03 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-6WXG4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:36:03 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-VhGOgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:36:03 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-TT6zQj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:36:03 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-1gJCDD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:36:03 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-1JLpXe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:36:03 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-qcvMgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:36:03 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-VRTEuP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:36:04 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-iKqynt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:36:04 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-NJjA4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:36:04 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-u19o08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:36:04 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-6C2oOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:36:04 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-0NNT_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:36:04 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-2P6Ipw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:36:04 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-m7pj7v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:36:04 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-UXFyeY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:36:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:36:05 INFO - Running setup.py install for manifestparser 05:36:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:36:05 INFO - Running setup.py install for mozcrash 05:36:05 INFO - Running setup.py install for mozdebug 05:36:05 INFO - Running setup.py install for mozdevice 05:36:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:36:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:36:05 INFO - Running setup.py install for mozfile 05:36:05 INFO - Running setup.py install for mozhttpd 05:36:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:36:06 INFO - Running setup.py install for mozinfo 05:36:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:36:06 INFO - Running setup.py install for mozInstall 05:36:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:36:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:36:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:36:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:36:06 INFO - Running setup.py install for mozleak 05:36:06 INFO - Running setup.py install for mozlog 05:36:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:36:06 INFO - Running setup.py install for moznetwork 05:36:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:36:06 INFO - Running setup.py install for mozprocess 05:36:07 INFO - Running setup.py install for mozprofile 05:36:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:36:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:36:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:36:07 INFO - Running setup.py install for mozrunner 05:36:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:36:07 INFO - Running setup.py install for mozscreenshot 05:36:07 INFO - Running setup.py install for moztest 05:36:07 INFO - Running setup.py install for mozversion 05:36:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:36:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:36:08 INFO - Cleaning up... 05:36:08 INFO - Return code: 0 05:36:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:36:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10b18ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1f9228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe01f2e680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1419f0>, '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 0x10aea0cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b10b990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GNVMHtXvPt/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.2m2FLfLJYQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:36:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 05:36:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 05:36:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GNVMHtXvPt/Render', 05:36:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:08 INFO - 'HOME': '/Users/cltbld', 05:36:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:08 INFO - 'LOGNAME': 'cltbld', 05:36:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:08 INFO - 'MOZ_NO_REMOTE': '1', 05:36:08 INFO - 'NO_EM_RESTART': '1', 05:36:08 INFO - 'PAGER': '/bin/cat', 05:36:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:08 INFO - 'PWD': '/builds/slave/test', 05:36:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:08 INFO - 'SHELL': '/bin/bash', 05:36:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2m2FLfLJYQ/Listeners', 05:36:08 INFO - 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/', 05:36:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:08 INFO - 'USER': 'cltbld', 05:36:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:08 INFO - 'XPC_FLAGS': '0x0', 05:36:08 INFO - 'XPC_SERVICE_NAME': '0', 05:36:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:36:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:36:08 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-eNcXKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:36:08 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)) 05:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:36:08 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-1cncGH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:36:08 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)) 05:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:36:08 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-NsTl0x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:36:08 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)) 05:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:36:08 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-2MMQrd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:36:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 05:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:36:08 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-CyksvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:36:09 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)) 05:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:36:09 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-mUozWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:36:09 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)) 05:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:36:09 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-HF2oVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:36:09 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)) 05:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:36:09 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-_QJdnU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:36:09 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)) 05:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:36:09 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-MUKjzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:36:09 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)) 05:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:36:09 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-NlbQgw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:36:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 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)) 05:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:36:09 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-LXBEH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:36:09 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)) 05:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:36:09 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-A8_7pH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:36:09 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)) 05:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:36:09 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-s6fCpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:36:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 05:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:36:10 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-zGLrJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:36:10 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)) 05:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:36:10 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-2eokya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:36:10 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)) 05:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:36:10 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-E7erPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:36:10 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)) 05:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:36:10 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-4fA9bG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:36:10 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)) 05:36:10 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)) 05:36:10 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)) 05:36:10 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)) 05:36:10 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:36:10 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:36:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:36:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:12 INFO - Downloading blessings-1.5.1.tar.gz 05:36:12 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 05:36:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:36:13 INFO - Installing collected packages: blessings 05:36:13 INFO - Running setup.py install for blessings 05:36:13 INFO - Successfully installed blessings 05:36:13 INFO - Cleaning up... 05:36:13 INFO - Return code: 0 05:36:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:36:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:36:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:36:13 INFO - Reading from file tmpfile_stdout 05:36:13 INFO - Current package versions: 05:36:13 INFO - blessings == 1.5.1 05:36:13 INFO - blobuploader == 1.2.4 05:36:13 INFO - docopt == 0.6.1 05:36:13 INFO - manifestparser == 1.1 05:36:13 INFO - mozInstall == 1.12 05:36:13 INFO - mozcrash == 0.16 05:36:13 INFO - mozdebug == 0.1 05:36:13 INFO - mozdevice == 0.47 05:36:13 INFO - mozfile == 1.2 05:36:13 INFO - mozhttpd == 0.7 05:36:13 INFO - mozinfo == 0.9 05:36:13 INFO - mozleak == 0.1 05:36:13 INFO - mozlog == 3.0 05:36:13 INFO - moznetwork == 0.27 05:36:13 INFO - mozprocess == 0.22 05:36:13 INFO - mozprofile == 0.27 05:36:13 INFO - mozrunner == 6.11 05:36:13 INFO - mozscreenshot == 0.1 05:36:13 INFO - mozsystemmonitor == 0.0 05:36:13 INFO - moztest == 0.7 05:36:13 INFO - mozversion == 1.4 05:36:13 INFO - psutil == 3.1.1 05:36:13 INFO - requests == 1.2.3 05:36:13 INFO - wsgiref == 0.1.2 05:36:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:36:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10b18ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1f9228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe01f2e680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1419f0>, '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 0x10aea0cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b10b990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GNVMHtXvPt/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.2m2FLfLJYQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:36:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 05:36:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 05:36:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GNVMHtXvPt/Render', 05:36:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:13 INFO - 'HOME': '/Users/cltbld', 05:36:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:13 INFO - 'LOGNAME': 'cltbld', 05:36:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:13 INFO - 'MOZ_NO_REMOTE': '1', 05:36:13 INFO - 'NO_EM_RESTART': '1', 05:36:13 INFO - 'PAGER': '/bin/cat', 05:36:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:13 INFO - 'PWD': '/builds/slave/test', 05:36:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:13 INFO - 'SHELL': '/bin/bash', 05:36:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2m2FLfLJYQ/Listeners', 05:36:13 INFO - 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/', 05:36:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:13 INFO - 'USER': 'cltbld', 05:36:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:13 INFO - 'XPC_FLAGS': '0x0', 05:36:13 INFO - 'XPC_SERVICE_NAME': '0', 05:36:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:36:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:14 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 1)) 05:36:14 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 2)) 05:36:14 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 3)) 05:36:14 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 4)) 05:36:14 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 5)) 05:36:14 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 6)) 05:36:14 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 7)) 05:36:14 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 8)) 05:36:14 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.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:36:14 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 3)) 05:36:14 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.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:36:14 INFO - Cleaning up... 05:36:14 INFO - Return code: 0 05:36:14 INFO - Running post-action listener: _resource_record_post_action 05:36:14 INFO - Running post-action listener: _start_resource_monitoring 05:36:14 INFO - Starting resource monitoring. 05:36:14 INFO - ##### 05:36:14 INFO - ##### Running install step. 05:36:14 INFO - ##### 05:36:14 INFO - Running pre-action listener: _resource_record_pre_action 05:36:14 INFO - Running main action method: install 05:36:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:36:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:36:14 INFO - Reading from file tmpfile_stdout 05:36:14 INFO - Detecting whether we're running mozinstall >=1.0... 05:36:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:36:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:36:14 INFO - Reading from file tmpfile_stdout 05:36:14 INFO - Output received: 05:36:14 INFO - Usage: mozinstall [options] installer 05:36:14 INFO - Options: 05:36:14 INFO - -h, --help show this help message and exit 05:36:14 INFO - -d DEST, --destination=DEST 05:36:14 INFO - Directory to install application into. [default: 05:36:14 INFO - "/builds/slave/test"] 05:36:14 INFO - --app=APP Application being installed. [default: firefox] 05:36:14 INFO - mkdir: /builds/slave/test/build/application 05:36:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:36:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:36:52 INFO - Reading from file tmpfile_stdout 05:36:52 INFO - Output received: 05:36:52 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:36:52 INFO - Running post-action listener: _resource_record_post_action 05:36:52 INFO - ##### 05:36:52 INFO - ##### Running run-tests step. 05:36:52 INFO - ##### 05:36:52 INFO - Running pre-action listener: _resource_record_pre_action 05:36:52 INFO - Running main action method: run_tests 05:36:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:36:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:36:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:36:52 INFO - 2015-11-05 05:36:52.880 screenresolution[1630:7520] starting screenresolution argv=screenresolution get 05:36:52 INFO - 2015-11-05 05:36:52.884 screenresolution[1630:7520] Display 0: 1600x1200x32@60 05:36:52 INFO - 2015-11-05 05:36:52.890 screenresolution[1631:7522] starting screenresolution argv=screenresolution list 05:36:52 INFO - Available Modes on Display 0 05:36:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:36:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:36:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:36:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:36:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:36:53 INFO - Intel HD Graphics 3000: 05:36:53 INFO - Chipset Model: Intel HD Graphics 3000 05:36:53 INFO - Type: GPU 05:36:53 INFO - Bus: Built-In 05:36:53 INFO - VRAM (Total): 512 MB 05:36:53 INFO - VRAM (Dynamic, Max): 10 05:36:53 INFO - Vendor: Intel (0x8086) 05:36:53 INFO - Device ID: 0x0116 05:36:53 INFO - Revision ID: 0x0009 05:36:53 INFO - Displays: 05:36:53 INFO - Display: 05:36:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:36:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:36:53 INFO - Display Serial Number: 1600x1200 60 05:36:53 INFO - Main Display: Yes 05:36:53 INFO - Mirror: Off 05:36:53 INFO - Online: Yes 05:36:53 INFO - Rotation: Supported 05:36:53 INFO - Return code: 0 05:36:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:36:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:36:53 INFO - Python 2.7.3 05:36:53 INFO - Return code: 0 05:36:53 INFO - grabbing minidump binary from tooltool 05:36:53 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')]} 05:36:53 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 0x10b1419f0>, '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 0x10aea0cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b10b990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:36:53 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 05:36:53 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 05:36:53 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:36:53 INFO - Return code: 0 05:36:53 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:36:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:36:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:36:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:36:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:36:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/4HLF7bZtSW-wpSI8QhQYsg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0097', '--webServer', 'localhost'] in /builds/slave/test/build 05:36:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/4HLF7bZtSW-wpSI8QhQYsg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0097 --webServer localhost 05:36:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GNVMHtXvPt/Render', 05:36:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:53 INFO - 'HOME': '/Users/cltbld', 05:36:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:53 INFO - 'LOGNAME': 'cltbld', 05:36:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:36:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:36:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:53 INFO - 'MOZ_NO_REMOTE': '1', 05:36:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:36:53 INFO - 'NO_EM_RESTART': '1', 05:36:53 INFO - 'PAGER': '/bin/cat', 05:36:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:53 INFO - 'PWD': '/builds/slave/test', 05:36:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:36:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:53 INFO - 'SHELL': '/bin/bash', 05:36:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2m2FLfLJYQ/Listeners', 05:36:53 INFO - 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/', 05:36:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:53 INFO - 'USER': 'cltbld', 05:36:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:53 INFO - 'XPC_FLAGS': '0x0', 05:36:53 INFO - 'XPC_SERVICE_NAME': '0', 05:36:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:36:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/4HLF7bZtSW-wpSI8QhQYsg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0097', '--webServer', 'localhost'] with output_timeout 3600 05:36:53 INFO - mozversion INFO | application_buildid: 20151105031836 05:36:53 INFO - mozversion INFO | application_changeset: bad16f7ef2ce7b0d2e87c384dd0cf9ef314156f5 05:36:53 INFO - mozversion INFO | application_display_name: Nightly 05:36:53 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:36:53 INFO - mozversion INFO | application_name: Firefox 05:36:53 INFO - mozversion INFO | application_remotingname: firefox 05:36:53 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 05:36:53 INFO - mozversion INFO | application_vendor: Mozilla 05:36:53 INFO - mozversion INFO | application_version: 45.0a1 05:36:53 INFO - mozversion INFO | platform_buildid: 20151105031836 05:36:53 INFO - mozversion INFO | platform_changeset: bad16f7ef2ce7b0d2e87c384dd0cf9ef314156f5 05:36:53 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 05:36:53 INFO - mozversion INFO | platform_version: 45.0a1 05:36:53 INFO - 2015-11-05 05:36:53,575 DEBUG : using testdate: 1446730613 05:36:53 INFO - 2015-11-05 05:36:53,575 DEBUG : actual date: 1446730613 05:36:53 INFO - 2015-11-05 05:36:53,653 INFO : starting webserver on 'localhost:49261' 05:36:53 INFO - 2015-11-05 05:36:53,654 INFO : Starting test suite t-yosemite-r5-0097.e 05:36:53 INFO - 2015-11-05 05:36:53,654 INFO : Starting test dromaeo_css 05:36:53 INFO - 2015-11-05 05:36:53,654 DEBUG : operating with platform_type : mac_ 05:36:53 INFO - 2015-11-05 05:36:53,655 INFO : Initialising browser for dromaeo_css test... 05:36:53 INFO - 2015-11-05 05:36:53,669 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/tmp71tdSx/profile http://localhost:49261/getInfo.html 05:36:57 INFO - 2015-11-05 05:36:57,177 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:36:57 INFO - 2015-11-05 05:36:57,178 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:36:57 INFO - 2015-11-05 05:36:57,178 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:36:57 INFO - 2015-11-05 05:36:57,178 DEBUG : BROWSER_OUTPUT: __metrics 05:36:57 INFO - 2015-11-05 05:36:57,842 INFO : Browser initialized. 05:36:57 INFO - 2015-11-05 05:36:57,842 INFO : Running cycle 1/1 for dromaeo_css test... 05:36:57 INFO - 2015-11-05 05:36:57,842 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/tmp71tdSx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:37:09 INFO - 2015-11-05 05:37:09,881 DEBUG : BROWSER_OUTPUT: RSS: Main: 233619456 05:37:09 INFO - 2015-11-05 05:37:09,881 DEBUG : BROWSER_OUTPUT: 05:37:59 INFO - 2015-11-05 05:37:59,728 DEBUG : BROWSER_OUTPUT: 1446730679728 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] 05:40:09 INFO - 2015-11-05 05:40:09,214 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49261/tests/dromaeo/cssquery-ext.html) 05:40:10 INFO - 2015-11-05 05:40:10,323 DEBUG : BROWSER_OUTPUT: RSS: Main: 256516096 05:40:10 INFO - 2015-11-05 05:40:10,323 DEBUG : BROWSER_OUTPUT: 05:43:12 INFO - 2015-11-05 05:43:12,515 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/dromaeo/cssquery-ext.html (next: http://localhost:49261/tests/dromaeo/cssquery-jquery.html) 05:43:13 INFO - 2015-11-05 05:43:13,098 DEBUG : BROWSER_OUTPUT: RSS: Main: 263598080 05:43:13 INFO - 2015-11-05 05:43:13,099 DEBUG : BROWSER_OUTPUT: 05:46:14 INFO - 2015-11-05 05:46:14,835 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49261/tests/dromaeo/cssquery-mootools.html) 05:46:15 INFO - 2015-11-05 05:46:15,409 DEBUG : BROWSER_OUTPUT: RSS: Main: 266260480 05:46:15 INFO - 2015-11-05 05:46:15,409 DEBUG : BROWSER_OUTPUT: 05:49:17 INFO - 2015-11-05 05:49:17,127 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49261/tests/dromaeo/cssquery-prototype.html) 05:49:17 INFO - 2015-11-05 05:49:17,714 DEBUG : BROWSER_OUTPUT: RSS: Main: 271994880 05:49:17 INFO - 2015-11-05 05:49:17,714 DEBUG : BROWSER_OUTPUT: 05:52:20 INFO - 2015-11-05 05:52:20,243 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49261/tests/dromaeo/cssquery-yui.html) 05:52:20 INFO - 2015-11-05 05:52:20,861 DEBUG : BROWSER_OUTPUT: RSS: Main: 276086784 05:52:20 INFO - 2015-11-05 05:52:20,861 DEBUG : BROWSER_OUTPUT: 05:55:23 INFO - 2015-11-05 05:55:23,226 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/dromaeo/cssquery-yui.html (next: http://localhost:49261/tests/dromaeo/cssquery-dojo.html) 05:55:23 INFO - 2015-11-05 05:55:23,470 DEBUG : BROWSER_OUTPUT: RSS: Main: 281096192 05:55:23 INFO - 2015-11-05 05:55:23,470 DEBUG : BROWSER_OUTPUT: 05:55:23 INFO - 2015-11-05 05:55:23,472 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:55:23 INFO - 2015-11-05 05:55:23,472 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:55:23 INFO - 2015-11-05 05:55:23,472 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:55:23 INFO - 2015-11-05 05:55:23,472 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:55:23 INFO - 2015-11-05 05:55:23,473 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2989.5964044853968;2993.2068001979464;2998.235449960261;3167.1765341011346;3168.572242747229;4884.560389564938;4943.332650092237;4970.900581988358;4971.328870602468;5014.824481143151;4797.448293446255;4813.8796530086765;4857.392825896763;4948.183549714293;4987.526185012427;4548.681592288541;4552.157850797613;4600.332951721998;4634.37435946148;4731.455882573497;25.20118782921532;4546.8408605698805;4603.861884143481;4631.189541830183;4673.112108699336;4555.4533455985165;4582.656300777455;4598.103369842882;4604.7927843247135;4618.284165954283;4546.522615125397;4606.378138951266;4606.424196975378;4613.7923793429045;4642.141203877293;4345.587169218919;4495.370648109268;4504.09918016398;4583.358329833826;4625.699329543602;4633.235516139833;4848.5636292733825;4862.17343051682;4910.140725373046;4992.276119962585;5098.7705553249825;5190.662606930575;5212.244224587452;5222.216667499867;5245.1869960155855;5153.175491921274;5235.790568377261;5252.369715634149;5324.148136298212;5356.625036247464;4904.386951631046;4917.852464426037;4968.180250258703;4973.626977976703;4985.90028199434;5319.973400132974;5395.595330350239;5462.180672899018;5465.836024919259;5480.945190548123;5011.273365362002;5036.546710796046;5076;5090.643654944192;5153.948460515422;5276.3932147802725;5286.550643195372;5310.495502927216;5351.983123206578;5375.731213439312;5054.545090941833;5213.869653258623;5221.242919776687;5260.13207820713;5285.418603953562;5113.284140220372;5124.461931497139;5186.792528298825;5193.1171700810955;5223.791048358099;4031.1937612477623;4043.7978101095414;4059.330210515232;4134.049168691218;4141.482314710661;3630.5824830144343;3692.7230457715777;3715.7398982070995;3739.7195210358786;3828.253490569368;4877.707337559757;4886.242632391985;4931.58081563064;4995.400551933792;5015.924761128586;5272.841814745564;5321.467853214725;5327.227552005015;5387.218853266333;5400.540954018874;4821.63837712173;4920.655554111249;5004.699718016931;5021.422536408287;5024.472430394756;4689.085628302517;4690.061987602493;4696.882577935579;4702.6473014524045;4773.76131193439;5416.485433883775;5425.565954723534;5469.234307196995;5472.015037293246;5486.231927530149;5224.555912747307;5323.228131920772;5344.679319240858;5358.732063396893;5385.461453854583;5317.7341132943975;5381.11211650089;5383.08487557124;5438.184272359178;5441.29263195782;5246.711430871339;5263;5276.683398996072;5285.788568457218;5299.655522391032;5137.563307118937;5203.089459344676;5266;5299.258103865539;5421.783128674809;5228.738563071755;5270.657407268515;5275.604329675213;5277.050130976461;5298.072837253389;5045.84862454127;5220.738963051908;5278.868028299324;5284.524392804666;5310.495502927216;5002.52476014778;5038.546530812245;5049.2173713074535;5102;5116.590672746246;5037.596992240685;5224.9738751306;5234.731617958139;5242.68543887368;5245.160774276097;4927.852164435073;5072.721000345016;5132.538071573427;5149.7682604282145;5159.993801208729 05:55:23 INFO - 2015-11-05 05:55:23,477 DEBUG : BROWSER_OUTPUT: |1;ext.html;507.188498402556;518.5151882989404;524.4048005513744;542.0730550758202;542.7530473634497;36790;37868.621313786854;37872.81063594685;37889.43165852514;38001.619983800156;39849;40336;40441.39337909934;40532.39201411981;40764.796176019154;8481.533515656636;8651.091635378289;8659.69691060813;8679.349048821332;8755.474671519698;8466.576671166447;8570.82858342836;8591.785205369853;8595.097514760953;8665.566721663923;8153.836923261531;8487.236148746611;8574.957125214396;8578.313734901192;8666.39335246533;8566.48601083937;8567.143285671445;8585.570721463902;8664.783380415509;8697.913020869773;8386.706465273686;8429.70496032642;8510.659573617047;8525.232729054353;8537.829243415097;36853.815730921444;36857.44713829295;36921.26157476862;37308;37317.44023839645;2412.2039726890084;2528.471725211227;2614.712381638018;2896.9130926072253;2913.6357955255594;24571.87714061436;24957.376065598324;25341.87329063361;25921;26142.477150457074;2217.8780167090804;2248.977510224893;2251.5609456156058;2256.9661455078185;2290.7594702556157;242873;243399;245544;246104;246761;39181.60818391779;39399.21201575953;39493.605063949566;39742.20515589672;52100.21849672258;40161.799191003855;40742;40834.59165408367;41210.58789412127;41285.79357103195;12642.494300228072;12676.619701408972;12823;12925.095243333064;12972.935135324264;9904.059114384121;9966.651167209258;9976.80046399068;10134.23993200513;10170.949145254226;12886.742265154644;13141.868581314257;13181.209127452383;13191.472341106248;13261.469541218436;5864.6834500372115;5888;6005.549583781234;6005.558665920235;6030.095485677183;891.6299735609779;894.7763059235191;911.0434044253508;1011.3830563356347;1093.1691914145306;26633.33416664599;26817.463650726877;26845.194644160707;26897.86551067232;26903.461930761274;1008.4856723071287;1020.0666390252984;1021.5505177721927;1026.7330494071596;1119.5074167366333;13833.378776987174;13961;14041.1575305482;14074.507392241223;14111;285615;290067;290937;292207;293022;50773.95356278635;51423.97152056938;51893;51954.74022629863;52322.47677523252;1265.6139877337316;1290.748304080714;1298.2535042350687;1309.1294289297512;1312.3831799054428;26204.868975655;27006;27037.324066898484;27232.455350893266;29547.261318467212;48721;49451.752741237506;49510;49930.75034624804;50391.74804125956;258449;260442;260501;261318;263187;39394.60605394024;40003.39994900021;41076.79461602673;42713.78643106889;43215;39318.6186126693;40100.19799603933;40632.39051414172;41066.79466602648;41130.79434602808;33137.171570710925;33736;34249;34267.828660857536;34403;33219;33324.166895827795;33407.84799009992;33519.664803351654;33941.66058339385;33913.49129763006;34175;34444;34663;35046.82476587601;29465.705342946298;29702.257443564085;29823.25441863884;30106.69893301039;30256.243593909447;22788.202412915467;22961.196358127385;23091.076356945534;23251.3024609262;23329.76670233344 05:55:23 INFO - 2015-11-05 05:55:23,477 DEBUG : BROWSER_OUTPUT: |2;jquery.html;306.75153125967967;307.5893681934617;313.2044606698983;318.1299146833411;323.936832317698;10978.396188209645;11436.256643318178;16300.429484968014;16702.415415460462;16933;10873.619423320166;10996;11006.229563930528;11024.283421577611;11102.167337449684;4012.699047571429;4169.207850508409;4170.624643782059;4176.7076304658685;4181.540030596647;3989.8603548875794;4070.5725898780647;4111.691623128262;4114.033202197481;4177.51958524769;4034.7579145251234;4097.3853921911805;4136.751794892316;4205.327147656376;4281.785910704468;4279.0799978004725;4285.550017248175;4285.8071386787515;4293.656507479394;4305.246581848164;3550.8757193498363;3561.4301711726;3578.481120237551;3591.6587924147166;3608.458731190316;11895.345755983417;12107.757844843141;12136.87863121375;12288.324142172178;12321.75356492874;1785.4018903667286;1810.3030333321635;1832.0428471258751;1849.3619701203063;1859.6745569525278;8963.417377870417;9052.637894484213;9075.773105672344;9080.909190908073;9162.267018638493;1413.6041908265702;1430.6637940084072;1446.7902154187689;1462.2615579132575;1536.6004838742008;54926.72536637331;56495.71752141213;56518;56961.430385696025;57855.13217301744;5983.700814959235;5996.580239383288;6089.208402907594;6089.421504957022;6176.8764624707255;6902.206246281742;6927.134108236471;6978.092847929736;6979.267176946449;7003.719851205997;4720.811167553259;4750.881227969328;4809.9038019240115;4925.21196608541;4992.425871024806;5117.462666419972;5125.051865404912;5133.383993920754;5151.304573882553;5206.895862082737;2682.9597556036674;2697.1234348836706;2713.9050133245637;2721.034032918325;2727.0864260472963;973.3673112476947;977.6822532676766;979.1334668818005;981.3719219699398;1032.6747074671455;362.2899117729228;364.16605972323083;373.4510269903238;377.1269511081837;384.26413418304196;9246.876122799255;9506.239500839916;9601.47191904452;9749.220062394992;10357.22320825926;374.6777771116837;385.6432799660303;393.8168751530552;394.4773175542418;397.85478300420715;5252.842414727565;5411.026015317202;5425.186222066643;5496.7526461309335;5527.50252477279;486564;488983;491055;493791;499904;61489.999999999105;64240.678796605716;66182.33817661762;67231.66384168048;68212;451.652227784604;456.0696179793251;466.1771972468596;474.3975151557503;477.7969363020702;9943.801123977335;10159.288849780445;10188.694339169837;10205.438700871226;10254.846177307496;29686.257843554085;31315.21711957128;31674.68325316717;32317;33123.66876331206;40673.1865362697;41710;42404.57595424006;42459.78770106253;42809;5482.725863706878;5578.721063946868;5671.914921276267;5732.9680657480385;5786.3056433228285;10307.94846025765;10886.945565272123;10979.17656175774;10980.615678451215;11010.779784404427;9113.635454581743;9221.262299016196;9358.766030849283;9380.953095234754;9471.10024547667;8962.238209752244;9109.316801239802;9218.585163667785;9253.306002049738;9388.812223755624;9215.078492150731;9449.905500945177;9847.556859941464;9881.85177222328;9937.055979681918;5433.864153396196;5709.600327977168;5731.627444216113;5771.769129234784;5803.506701930383;9133.543322833964;9221.723348299562;9412.058794120534;9427.670031548863;9518.190953769008 05:55:23 INFO - 2015-11-05 05:55:23,481 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1462.5100591301914;1572.811262648482;1639.303296099158;1654.9751753723697;1661.244133919067;6363.681815909197;6537.411632953033;6957.130358705162;7190.604516751583;7268;6740.561863478871;6992.6154061526595;7073.575585464876;7093.503454758169;7098.148222213329;2015.244283393731;2031.3195079648335;2033.888136152511;2039.1537511932531;2041.846861485387;2029.8782073075588;2060.8969551522437;2067.586482703465;2074.751029876417;2075.1595603780415;2008.3472871316808;2055.7224774655456;2088.926887558936;2089.6552068908613;2091.7699053104147;1983.7421135252398;1995.9002049897592;2000.2699014859618;2004.7794742578305;2008.0963566395108;2002.0890494824819;2004.4387571480008;2030.0864610924996;2032.1871251499372;2036.8268697160759;7028.964855175743;7058;7138.321859423347;7139.964300178518;7164.247753985808;4276.5295817460055;4297.183535128315;4351.782410879475;4354.608085272309;4370.606645401929;2306.976930230693;2371.8221133415063;2597.8181527293095;2665.7867370610306;2665.973340266592;779.9727009554638;809.6963638635511;811.5779794506824;822.0628483528782;824.0194168939004;9080.364374493787;9081.863772043358;9136.954315228448;9205.03347148553;9271.490068046254;3873.0704630888386;3967.4247234150885;4025.879223623296;4065.4308396824467;4070.2266569351727;8003.359731221604;8127.268545830903;8133.877991830127;8140.75577732669;8141.552214628134;4431.800568974404;4469.642428605704;4472.530384309601;4473.530279320625;4483.237849565582;4047.170330082326;4055.1078762672164;4096.487939007624;4100.302948498763;4104.035551645361;3351;3390.5083762854247;3418.2821607462215;3426.9657303427143;3434.5019972104405;1029.3206483720708;1040.1210976724656;1044.3525014491065;1059.3749687684303;1060.7295139739317;1185.1170877696172;1195.49789088583;1208.7582483503334;1224.8468941382328;1242.2484396939901;6597.373249541286;6615.17310336208;6704;6732.596044237362;6749.358810912955;402.95768944261016;417.887170463973;419.0571214766775;419.2579134931155;422.5837550013234;5065.544101030925;5099.847004589868;5140.974295128501;5145.536901678867;5152.3044389007755;7366.300201480851;7689.538627682357;7948.960255198803;8030.638621262057;8293.585320733939;8154.613715668351;8173.223543763452;8236.876446853303;8237.711680091288;8264.380171487162;6511.8697626047215;6539.607623542603;6606.471482281406;6685.264620891698;6700.463962882957;6404.327545607644;6464;6475.579087359307;6480.611163330215;6492.220933488012;7252.419806415369;7318.414526837733;7432.851342973218;7555.395568354628;7636.694532218649;7561.281678240558;7628.38972882157;7715.112762032214;7723.189065148304;7730.574818385043;6220.222472190976;6240.063990401294;6271.027990661455;6272.560920735505;6276.686165691788;6745.5952642841585;6807.625580592917;6863.656817159222;6885.931140688529;6896.27589103137;6315.052742088724;6368.235811702625;6387.489000879826;6459.61242325462;6481;6212.937870621417;6275.246970363585;6286.088517164894;6326.6520341381665;6359.300476947439;6331.27190373113;6458.289588145394;6470.38531339522;6472.126262954441;6480.449161821298;5753.884922301614;5822.184894114743;5823.242978412779;5831.562632802472;5834.124881267844;5877.617954832922;5892.499137573354;5965.701714914324;5972.044472884318;5998.310194327708 05:55:23 INFO - 2015-11-05 05:55:23,482 DEBUG : BROWSER_OUTPUT: |4;prototype.html;292.3962018431938;295.9274977630481;299.5626385477203;301.6289963345086;303.1678043769852;5749.396313387097;5821.592488525805;5821.9999999999945;5892.793752218673;5910.3203131639875;5673.631213971089;5683.318001839774;5731.684757338345;5772.393898640635;5776.480116789488;4333.891652708676;4389.890252743675;4398.670099742516;4429.579189976963;4460.910781784362;4373.825046998117;4374.300111982084;4405.140997505488;4414.845480408187;4439.8446054388105;4340.609345158935;4342.956570434302;4344.413504176927;4377.190219809346;4385.978070109645;4227.957720422787;4343.326784348431;4344.89137771555;4347.804348804311;4394.560543945596;3742.5696044954907;3746.981265093684;3749.737518373715;3760.52993375828;3763.1344790698017;5506.421825708283;5571.832845014656;5619.409961953977;5653.971730141323;5665.66006039639;4903.583195428393;4943.036107958949;4946.084974279734;4950;4953.5541801237705;5991.850203744898;5997.8800423991715;5998.910016349758;6042.456178943872;6055.515558755289;3987.142764305688;4031.5565287818317;4059.8579049733116;4085.44846445729;4094.28350038742;6264.154339164245;6329.398707122816;6331.2085989251345;6358.713857876361;6362.331955144689;4222.59885310895;4229.830806767756;4237.660987121023;4239.936400953989;4260.275753121977;4268.445102136764;4302.698811083257;4330;4334.371516130143;4335.6965012449455;4846.36997190363;4975.676581022222;4982.750862456863;4983.953369792384;4988.276699878497;6037.305709843425;6050.878982420327;6075.453209211104;6079.604825686405;6102.664353460602;1516.9014014089048;1534.087218105248;1553.3864123671312;1556.820965588949;1558.2286768049887;987.3976874106789;988.3476905242505;1015.8984101589782;1022.8363461846069;1039.34521251611;5828.825135245949;5862.443067908627;5866.5893387462465;5895.734691938873;5904.0553511437965;6265.467435268053;6270.968645156745;6307.905381419282;6309.179806625109;6309.369063093745;5874.118882167623;5880.0297950838485;5882.941170588239;5901;5927.1405646181065;3351.3464874349756;3448.706859916885;3478.0261526772542;3482.233908540117;3482.460218666111;6258.9374106259265;6404.199475065617;6429.453496452854;6466.902996455057;6476.967615161988;6389.169407977026;6439.678016099177;6451.870962580722;6508.121403610452;6546.672666366662;6373.362663733589;6394.360563943568;6395.808125756234;6425.742970281136;6462.289148193601;6110.114033465212;6281.246250449975;6285;6296.5592408530965;6300.054991751274;6140.723667435065;6156.199694039746;6173.228346456693;6277.780277690259;6319.747210111728;6452.354764523698;6453.967730161319;6455.903161452488;6456.870047741532;6519.7392104315295;4090.9795451022555;4128;4132.111596006873;4135.77253251074;4145.8963525912095;6139.508839292936;6278.309385967448;6336.683165841781;6407.231132264158;6418.326075761977;6164.660943647963;6186.659733714689;6191.133241346305;6217.689115544295;6219.160413344141;6029.879402412015;6072.787452439144;6103.969480152571;6146.877062458636;6183.907241391473;5843.094320380348;5968.820935371946;6000.51995840323;6003.549733769897;6036.607620504653;6111.694415279308;6154.876902462015;6187.041008643668;6189.96905015472;6265;6063.969680151571;6069.575129740876;6086.6652334122045;6089.48239399656;6100.664463454553 05:55:23 INFO - 2015-11-05 05:55:23,485 DEBUG : BROWSER_OUTPUT: |5;yui.html;677.2211956250311;697.5047716121557;718.5832217313958;724.4530379563429;724.7716969154716;12971.156874803142;13218.60344189676;13318.13432126911;13383.464661413533;13417.12788668737;12904.548340808074;13128.212307261547;13187.208767473958;13248.470061197564;13275;822.8642274024779;827.1604321613552;834.9332053435711;837.6649340263882;844.7212419901449;821.4126899267023;827.9130691277419;833.8992529860557;842.2546046748611;842.3598065470256;856.2379482260793;856.2935578148022;858.8582883824192;866.1684782608703;866.1901122450497;854.0647990450478;856.3919617071887;858.4548811504708;859.1151114352227;862.1680078723999;629.116091890894;629.4303655192059;629.9559030867841;630.0675000998502;630.5239544144142;12657;12797.48810047597;12836.229826210458;12852.421641026176;13010.219386836725;8797.736067917973;8893.866592001124;8950.507722075283;8992.8651070234;9332.766680832965;8385.916140838635;8504.914950850536;8522.360822938243;8572.785680357978;8643.481391116553;2761.654793150856;2764.8755805988576;2823.026056010673;2838.4181242845166;2897.0729366602695;43210.135797284194;43216;43462.13075738467;43837.34243986343;43873.78063109664;5917.112433135064;6064.545159113084;6090.817275481742;6266.780662676784;6541.247756507967;10927.3989930553;11055.72360690989;11098.389588572705;11105.278156919774;11113;5725.1698503716725;5736.368999410061;5878.441548052928;5966.075258334965;6005.6396616203165;3475.58293004841;3532.6643968822923;3577.373959557067;3617.9276414472088;3649.1424515238896;2466.8273220874366;2496.1388321029217;2496.6504689343506;2511.8869650865754;2512.899484020655;353.05029470723673;356.4706410979693;358.78652201939803;361.308094998081;365.532118887824;424.7663784918344;535.1090434426636;551.2585572405109;560.4927540575785;565.9122835960433;7454.589997550078;7458.276850044956;7571.659275332623;7720.575368354795;7723.729669461542;458.45443921733033;468.28352620490705;495.03715273792847;578.2165166199823;584.2200662116038;3468.722502199818;3542.946855797165;3602.3335682898746;3682.0610744260043;3685.7972811495624;57780;58186.709066454394;58371;58492.70753646205;58842.41157588369;49427.752861235465;50006.74996624994;50051.49948500541;50191.498085018684;50414.495855041714;45619.77190114028;45817;46240.3063954041;46278.537214627424;46449;7198.49610527258;7202.603856787927;7369.963150184215;7374.188839227573;7402.29678180572;33518.664813351555;33868;34259.314813704084;34359.828200858836;34635.30729385449;40835.79582102071;42017.78991105025;44865.77567112144;45034.3244851334;46203;6242.563020588515;6359.87280254383;6549.279579246184;6826.419754320938;6902.516823822284;9426.619132501593;9534.332596718163;9595.328327017041;9831.803363932824;10215.029572190928;8796.956015219883;8896.86654700193;9110.225630821455;9494.905050949403;9523.23826090426;9145.222656074307;9362.391444556082;9414.717558473258;9463.905360946577;9737.805243895224;8721.912780872364;8850.114988501098;9089.272858171198;9131.178193962574;9457.621695132118;7816.57008864518;7856.5678887661725;8023.719169829262;8042.9597852010365;8555.144485551395;7608.467407281437;7614.238576142341;8395.286400655768;8396.958015209884;8728.56357182151 05:55:23 INFO - 2015-11-05 05:55:23,485 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:55:23 INFO - 2015-11-05 05:55:23,485 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:55:23 INFO - 2015-11-05 05:55:23,486 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,283 05:55:23 INFO - 2015-11-05 05:55:23,486 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:55:23 INFO - 2015-11-05 05:55:23,486 DEBUG : BROWSER_OUTPUT: __startTimestamp1446731723471__endTimestamp 05:55:23 INFO - 2015-11-05 05:55:23,486 DEBUG : BROWSER_OUTPUT: 05:55:23 INFO - 2015-11-05 05:55:23,486 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:55:23 INFO - 2015-11-05 05:55:23,486 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:55:23 INFO - 2015-11-05 05:55:23,487 DEBUG : BROWSER_OUTPUT: 05:55:23 INFO - 2015-11-05 05:55:23,487 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4899.47 Median:5049.22 stddev:636.99 (12.6%) stddev-sans-first:621.07 05:55:23 INFO - 2015-11-05 05:55:23,487 DEBUG : BROWSER_OUTPUT: Values: 2989.6 2993.2 2998.2 3167.2 3168.6 4884.6 4943.3 4970.9 4971.3 5014.8 4797.4 4813.9 4857.4 4948.2 4987.5 4548.7 4552.2 4600.3 4634.4 4731.5 25.2 4546.8 4603.9 4631.2 4673.1 4555.5 4582.7 4598.1 4604.8 4618.3 4546.5 4606.4 4606.4 4613.8 4642.1 4345.6 4495.4 4504.1 4583.4 4625.7 4633.2 4848.6 4862.2 4910.1 4992.3 5098.8 5190.7 5212.2 5222.2 5245.2 5153.2 5235.8 5252.4 5324.1 5356.6 4904.4 4917.9 4968.2 4973.6 4985.9 5320.0 5395.6 5462.2 5465.8 5480.9 5011.3 5036.5 5076.0 5090.6 5153.9 5276.4 5286.6 5310.5 5352.0 5375.7 5054.5 5213.9 5221.2 5260.1 5285.4 5113.3 5124.5 5186.8 5193.1 5223.8 4031.2 4043.8 4059.3 4134.0 4141.5 3630.6 3692.7 3715.7 3739.7 3828.3 4877.7 4886.2 4931.6 4995.4 5015.9 5272.8 5321.5 5327.2 5387.2 5400.5 4821.6 4920.7 5004.7 5021.4 5024.5 4689.1 4690.1 4696.9 4702.6 4773.8 5416.5 5425.6 5469.2 5472.0 5486.2 5224.6 5323.2 5344.7 5358.7 5385.5 5317.7 5381.1 5383.1 5438.2 5441.3 5246.7 5263.0 5276.7 5285.8 5299.7 5137.6 5203.1 5266.0 5299.3 5421.8 5228.7 5270.7 5275.6 5277.1 5298.1 5045.8 5220.7 5278.9 5284.5 5310.5 5002.5 5038.5 5049.2 5102.0 5116.6 5037.6 5225.0 5234.7 5242.7 5245.2 4927.9 5072.7 5132.5 5149.8 5160.0 05:55:23 INFO - 2015-11-05 05:55:23,487 DEBUG : BROWSER_OUTPUT: 05:55:23 INFO - 2015-11-05 05:55:23,487 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42194.18 Median:34423.50 stddev:69443.67 (201.7%) stddev-sans-first:69567.94 05:55:23 INFO - 2015-11-05 05:55:23,487 DEBUG : BROWSER_OUTPUT: Values: 507.2 518.5 524.4 542.1 542.8 36790.0 37868.6 37872.8 37889.4 38001.6 39849.0 40336.0 40441.4 40532.4 40764.8 8481.5 8651.1 8659.7 8679.3 8755.5 8466.6 8570.8 8591.8 8595.1 8665.6 8153.8 8487.2 8575.0 8578.3 8666.4 8566.5 8567.1 8585.6 8664.8 8697.9 8386.7 8429.7 8510.7 8525.2 8537.8 36853.8 36857.4 36921.3 37308.0 37317.4 2412.2 2528.5 2614.7 2896.9 2913.6 24571.9 24957.4 25341.9 25921.0 26142.5 2217.9 2249.0 2251.6 2257.0 2290.8 242873.0 243399.0 245544.0 246104.0 246761.0 39181.6 39399.2 39493.6 39742.2 52100.2 40161.8 40742.0 40834.6 41210.6 41285.8 12642.5 12676.6 12823.0 12925.1 12972.9 9904.1 9966.7 9976.8 10134.2 10170.9 12886.7 13141.9 13181.2 13191.5 13261.5 5864.7 5888.0 6005.5 6005.6 6030.1 891.6 894.8 911.0 1011.4 1093.2 26633.3 26817.5 26845.2 26897.9 26903.5 1008.5 1020.1 1021.6 1026.7 1119.5 13833.4 13961.0 14041.2 14074.5 14111.0 285615.0 290067.0 290937.0 292207.0 293022.0 50774.0 51424.0 51893.0 51954.7 52322.5 1265.6 1290.7 1298.3 1309.1 1312.4 26204.9 27006.0 27037.3 27232.5 29547.3 48721.0 49451.8 49510.0 49930.8 50391.7 258449.0 260442.0 260501.0 261318.0 263187.0 39394.6 40003.4 41076.8 42713.8 43215.0 39318.6 40100.2 40632.4 41066.8 41130.8 33137.2 33736.0 34249.0 34267.8 34403.0 33219.0 33324.2 33407.8 33519.7 33941.7 33913.5 34175.0 34444.0 34663.0 35046.8 29465.7 29702.3 29823.3 30106.7 30256.2 22788.2 22961.2 23091.1 23251.3 23329.8 05:55:23 INFO - 2015-11-05 05:55:23,488 DEBUG : BROWSER_OUTPUT: 05:55:23 INFO - 2015-11-05 05:55:23,488 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24198.26 Median:2378.45 stddev:80653.94 (3391.0%) stddev-sans-first:80860.24 05:55:23 INFO - 2015-11-05 05:55:23,489 DEBUG : BROWSER_OUTPUT: Values: 306.8 307.6 313.2 318.1 323.9 10978.4 11436.3 16300.4 16702.4 16933.0 10873.6 10996.0 11006.2 11024.3 11102.2 4012.7 4169.2 4170.6 4176.7 4181.5 3989.9 4070.6 4111.7 4114.0 4177.5 4034.8 4097.4 4136.8 4205.3 4281.8 4279.1 4285.6 4285.8 4293.7 4305.2 3550.9 3561.4 3578.5 3591.7 3608.5 11895.3 12107.8 12136.9 12288.3 12321.8 1785.4 1810.3 1832.0 1849.4 1859.7 8963.4 9052.6 9075.8 9080.9 9162.3 1413.6 1430.7 1446.8 1462.3 1536.6 54926.7 56495.7 56518.0 56961.4 57855.1 5983.7 5996.6 6089.2 6089.4 6176.9 6902.2 6927.1 6978.1 6979.3 7003.7 4720.8 4750.9 4809.9 4925.2 4992.4 5117.5 5125.1 5133.4 5151.3 5206.9 2683.0 2697.1 2713.9 2721.0 2727.1 973.4 977.7 979.1 981.4 1032.7 362.3 364.2 373.5 377.1 384.3 9246.9 9506.2 9601.5 9749.2 10357.2 374.7 385.6 393.8 394.5 397.9 5252.8 5411.0 5425.2 5496.8 5527.5 486564.0 488983.0 491055.0 493791.0 499904.0 61490.0 64240.7 66182.3 67231.7 68212.0 451.7 456.1 466.2 474.4 477.8 9943.8 10159.3 10188.7 10205.4 10254.8 29686.3 31315.2 31674.7 32317.0 33123.7 40673.2 41710.0 42404.6 42459.8 42809.0 5482.7 5578.7 5671.9 5733.0 5786.3 10307.9 10886.9 10979.2 10980.6 11010.8 9113.6 9221.3 9358.8 9381.0 9471.1 8962.2 9109.3 9218.6 9253.3 9388.8 9215.1 9449.9 9847.6 9881.9 9937.1 5433.9 5709.6 5731.6 5771.8 5803.5 9133.5 9221.7 9412.1 9427.7 9518.2 05:55:23 INFO - 2015-11-05 05:55:23,489 DEBUG : BROWSER_OUTPUT: 05:55:23 INFO - 2015-11-05 05:55:23,491 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4898.58 Median:6216.58 stddev:2510.06 (40.4%) stddev-sans-first:2503.82 05:55:23 INFO - 2015-11-05 05:55:23,491 DEBUG : BROWSER_OUTPUT: Values: 1462.5 1572.8 1639.3 1655.0 1661.2 6363.7 6537.4 6957.1 7190.6 7268.0 6740.6 6992.6 7073.6 7093.5 7098.1 2015.2 2031.3 2033.9 2039.2 2041.8 2029.9 2060.9 2067.6 2074.8 2075.2 2008.3 2055.7 2088.9 2089.7 2091.8 1983.7 1995.9 2000.3 2004.8 2008.1 2002.1 2004.4 2030.1 2032.2 2036.8 7029.0 7058.0 7138.3 7140.0 7164.2 4276.5 4297.2 4351.8 4354.6 4370.6 2307.0 2371.8 2597.8 2665.8 2666.0 780.0 809.7 811.6 822.1 824.0 9080.4 9081.9 9137.0 9205.0 9271.5 3873.1 3967.4 4025.9 4065.4 4070.2 8003.4 8127.3 8133.9 8140.8 8141.6 4431.8 4469.6 4472.5 4473.5 4483.2 4047.2 4055.1 4096.5 4100.3 4104.0 3351.0 3390.5 3418.3 3427.0 3434.5 1029.3 1040.1 1044.4 1059.4 1060.7 1185.1 1195.5 1208.8 1224.8 1242.2 6597.4 6615.2 6704.0 6732.6 6749.4 403.0 417.9 419.1 419.3 422.6 5065.5 5099.8 5141.0 5145.5 5152.3 7366.3 7689.5 7949.0 8030.6 8293.6 8154.6 8173.2 8236.9 8237.7 8264.4 6511.9 6539.6 6606.5 6685.3 6700.5 6404.3 6464.0 6475.6 6480.6 6492.2 7252.4 7318.4 7432.9 7555.4 7636.7 7561.3 7628.4 7715.1 7723.2 7730.6 6220.2 6240.1 6271.0 6272.6 6276.7 6745.6 6807.6 6863.7 6885.9 6896.3 6315.1 6368.2 6387.5 6459.6 6481.0 6212.9 6275.2 6286.1 6326.7 6359.3 6331.3 6458.3 6470.4 6472.1 6480.4 5753.9 5822.2 5823.2 5831.6 5834.1 5877.6 5892.5 5965.7 5972.0 5998.3 05:55:23 INFO - 2015-11-05 05:55:23,491 DEBUG : BROWSER_OUTPUT: 05:55:23 INFO - 2015-11-05 05:55:23,491 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5080.30 Median:5877.07 stddev:1550.33 (26.4%) stddev-sans-first:1512.46 05:55:23 INFO - 2015-11-05 05:55:23,493 DEBUG : BROWSER_OUTPUT: Values: 292.4 295.9 299.6 301.6 303.2 5749.4 5821.6 5822.0 5892.8 5910.3 5673.6 5683.3 5731.7 5772.4 5776.5 4333.9 4389.9 4398.7 4429.6 4460.9 4373.8 4374.3 4405.1 4414.8 4439.8 4340.6 4343.0 4344.4 4377.2 4386.0 4228.0 4343.3 4344.9 4347.8 4394.6 3742.6 3747.0 3749.7 3760.5 3763.1 5506.4 5571.8 5619.4 5654.0 5665.7 4903.6 4943.0 4946.1 4950.0 4953.6 5991.9 5997.9 5998.9 6042.5 6055.5 3987.1 4031.6 4059.9 4085.4 4094.3 6264.2 6329.4 6331.2 6358.7 6362.3 4222.6 4229.8 4237.7 4239.9 4260.3 4268.4 4302.7 4330.0 4334.4 4335.7 4846.4 4975.7 4982.8 4984.0 4988.3 6037.3 6050.9 6075.5 6079.6 6102.7 1516.9 1534.1 1553.4 1556.8 1558.2 987.4 988.3 1015.9 1022.8 1039.3 5828.8 5862.4 5866.6 5895.7 5904.1 6265.5 6271.0 6307.9 6309.2 6309.4 5874.1 5880.0 5882.9 5901.0 5927.1 3351.3 3448.7 3478.0 3482.2 3482.5 6258.9 6404.2 6429.5 6466.9 6477.0 6389.2 6439.7 6451.9 6508.1 6546.7 6373.4 6394.4 6395.8 6425.7 6462.3 6110.1 6281.2 6285.0 6296.6 6300.1 6140.7 6156.2 6173.2 6277.8 6319.7 6452.4 6454.0 6455.9 6456.9 6519.7 4091.0 4128.0 4132.1 4135.8 4145.9 6139.5 6278.3 6336.7 6407.2 6418.3 6164.7 6186.7 6191.1 6217.7 6219.2 6029.9 6072.8 6104.0 6146.9 6183.9 5843.1 5968.8 6000.5 6003.5 6036.6 6111.7 6154.9 6187.0 6190.0 6265.0 6064.0 6069.6 6086.7 6089.5 6100.7 05:55:23 INFO - 2015-11-05 05:55:23,493 DEBUG : BROWSER_OUTPUT: 05:55:23 INFO - 2015-11-05 05:55:23,493 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12482.77 Median:5985.86 stddev:15803.81 (264.0%) stddev-sans-first:15823.29 05:55:23 INFO - 2015-11-05 05:55:23,494 DEBUG : BROWSER_OUTPUT: Values: 677.2 697.5 718.6 724.5 724.8 12971.2 13218.6 13318.1 13383.5 13417.1 12904.5 13128.2 13187.2 13248.5 13275.0 822.9 827.2 834.9 837.7 844.7 821.4 827.9 833.9 842.3 842.4 856.2 856.3 858.9 866.2 866.2 854.1 856.4 858.5 859.1 862.2 629.1 629.4 630.0 630.1 630.5 12657.0 12797.5 12836.2 12852.4 13010.2 8797.7 8893.9 8950.5 8992.9 9332.8 8385.9 8504.9 8522.4 8572.8 8643.5 2761.7 2764.9 2823.0 2838.4 2897.1 43210.1 43216.0 43462.1 43837.3 43873.8 5917.1 6064.5 6090.8 6266.8 6541.2 10927.4 11055.7 11098.4 11105.3 11113.0 5725.2 5736.4 5878.4 5966.1 6005.6 3475.6 3532.7 3577.4 3617.9 3649.1 2466.8 2496.1 2496.7 2511.9 2512.9 353.1 356.5 358.8 361.3 365.5 424.8 535.1 551.3 560.5 565.9 7454.6 7458.3 7571.7 7720.6 7723.7 458.5 468.3 495.0 578.2 584.2 3468.7 3542.9 3602.3 3682.1 3685.8 57780.0 58186.7 58371.0 58492.7 58842.4 49427.8 50006.7 50051.5 50191.5 50414.5 45619.8 45817.0 46240.3 46278.5 46449.0 7198.5 7202.6 7370.0 7374.2 7402.3 33518.7 33868.0 34259.3 34359.8 34635.3 40835.8 42017.8 44865.8 45034.3 46203.0 6242.6 6359.9 6549.3 6826.4 6902.5 9426.6 9534.3 9595.3 9831.8 10215.0 8797.0 8896.9 9110.2 9494.9 9523.2 9145.2 9362.4 9414.7 9463.9 9737.8 8721.9 8850.1 9089.3 9131.2 9457.6 7816.6 7856.6 8023.7 8043.0 8555.1 7608.5 7614.2 8395.3 8397.0 8728.6 05:55:23 INFO - 2015-11-05 05:55:23,494 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:55:23 INFO - 2015-11-05 05:55:23,495 DEBUG : BROWSER_OUTPUT: 05:55:23 INFO - 2015-11-05 05:55:23,946 INFO : Browser exited with error code: 0 05:55:23 INFO - 2015-11-05 05:55:23,977 INFO : Completed test dromaeo_css (00:18:30) 05:55:23 INFO - 2015-11-05 05:55:23,977 INFO : Starting test kraken 05:55:23 INFO - 2015-11-05 05:55:23,978 DEBUG : operating with platform_type : mac_ 05:55:23 INFO - 2015-11-05 05:55:23,978 INFO : Initialising browser for kraken test... 05:55:23 INFO - 2015-11-05 05:55:23,992 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/tmp3LMpZK/profile http://localhost:49261/getInfo.html 05:55:26 INFO - 2015-11-05 05:55:26,896 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:55:26 INFO - 2015-11-05 05:55:26,896 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:55:26 INFO - 2015-11-05 05:55:26,896 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:55:26 INFO - 2015-11-05 05:55:26,897 DEBUG : BROWSER_OUTPUT: __metrics 05:55:27 INFO - 2015-11-05 05:55:27,564 INFO : Browser initialized. 05:55:27 INFO - 2015-11-05 05:55:27,564 INFO : Running cycle 1/1 for kraken test... 05:55:27 INFO - 2015-11-05 05:55:27,564 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/tmp3LMpZK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:55:39 INFO - 2015-11-05 05:55:39,561 DEBUG : BROWSER_OUTPUT: RSS: Main: 233103360 05:55:39 INFO - 2015-11-05 05:55:39,561 DEBUG : BROWSER_OUTPUT: 05:55:42 INFO - 2015-11-05 05:55:42,106 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49261/tests/kraken/driver.html?testName=audio-beat-detection) 05:55:42 INFO - 2015-11-05 05:55:42,711 DEBUG : BROWSER_OUTPUT: RSS: Main: 251969536 05:55:42 INFO - 2015-11-05 05:55:42,711 DEBUG : BROWSER_OUTPUT: 05:55:45 INFO - 2015-11-05 05:55:45,461 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49261/tests/kraken/driver.html?testName=audio-dft) 05:55:46 INFO - 2015-11-05 05:55:46,059 DEBUG : BROWSER_OUTPUT: RSS: Main: 259739648 05:55:46 INFO - 2015-11-05 05:55:46,059 DEBUG : BROWSER_OUTPUT: 05:55:49 INFO - 2015-11-05 05:55:49,090 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49261/tests/kraken/driver.html?testName=audio-fft) 05:55:49 INFO - 2015-11-05 05:55:49,671 DEBUG : BROWSER_OUTPUT: RSS: Main: 260644864 05:55:49 INFO - 2015-11-05 05:55:49,671 DEBUG : BROWSER_OUTPUT: 05:55:51 INFO - 2015-11-05 05:55:51,766 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49261/tests/kraken/driver.html?testName=audio-oscillator) 05:55:52 INFO - 2015-11-05 05:55:52,358 DEBUG : BROWSER_OUTPUT: RSS: Main: 260014080 05:55:52 INFO - 2015-11-05 05:55:52,358 DEBUG : BROWSER_OUTPUT: 05:55:54 INFO - 2015-11-05 05:55:54,590 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49261/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:55:55 INFO - 2015-11-05 05:55:55,169 DEBUG : BROWSER_OUTPUT: RSS: Main: 261427200 05:55:55 INFO - 2015-11-05 05:55:55,169 DEBUG : BROWSER_OUTPUT: 05:55:58 INFO - 2015-11-05 05:55:58,385 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49261/tests/kraken/driver.html?testName=imaging-darkroom) 05:55:58 INFO - 2015-11-05 05:55:58,956 DEBUG : BROWSER_OUTPUT: RSS: Main: 261214208 05:55:58 INFO - 2015-11-05 05:55:58,956 DEBUG : BROWSER_OUTPUT: 05:56:02 INFO - 2015-11-05 05:56:02,292 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49261/tests/kraken/driver.html?testName=imaging-desaturate) 05:56:02 INFO - 2015-11-05 05:56:02,875 DEBUG : BROWSER_OUTPUT: RSS: Main: 261476352 05:56:02 INFO - 2015-11-05 05:56:02,875 DEBUG : BROWSER_OUTPUT: 05:56:05 INFO - 2015-11-05 05:56:05,976 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49261/tests/kraken/driver.html?testName=json-parse-financial) 05:56:06 INFO - 2015-11-05 05:56:06,568 DEBUG : BROWSER_OUTPUT: RSS: Main: 261799936 05:56:06 INFO - 2015-11-05 05:56:06,568 DEBUG : BROWSER_OUTPUT: 05:56:08 INFO - 2015-11-05 05:56:08,211 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49261/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:56:08 INFO - 2015-11-05 05:56:08,783 DEBUG : BROWSER_OUTPUT: RSS: Main: 260403200 05:56:08 INFO - 2015-11-05 05:56:08,783 DEBUG : BROWSER_OUTPUT: 05:56:10 INFO - 2015-11-05 05:56:10,675 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49261/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:56:11 INFO - 2015-11-05 05:56:11,292 DEBUG : BROWSER_OUTPUT: RSS: Main: 260616192 05:56:11 INFO - 2015-11-05 05:56:11,292 DEBUG : BROWSER_OUTPUT: 05:56:13 INFO - 2015-11-05 05:56:13,500 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49261/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:56:14 INFO - 2015-11-05 05:56:14,089 DEBUG : BROWSER_OUTPUT: RSS: Main: 260751360 05:56:14 INFO - 2015-11-05 05:56:14,089 DEBUG : BROWSER_OUTPUT: 05:56:16 INFO - 2015-11-05 05:56:16,865 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49261/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:56:17 INFO - 2015-11-05 05:56:17,461 DEBUG : BROWSER_OUTPUT: RSS: Main: 260878336 05:56:17 INFO - 2015-11-05 05:56:17,461 DEBUG : BROWSER_OUTPUT: 05:56:20 INFO - 2015-11-05 05:56:20,217 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49261/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:56:20 INFO - 2015-11-05 05:56:20,802 DEBUG : BROWSER_OUTPUT: RSS: Main: 260628480 05:56:20 INFO - 2015-11-05 05:56:20,802 DEBUG : BROWSER_OUTPUT: 05:56:22 INFO - 2015-11-05 05:56:22,568 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49261/tests/kraken/driver.html?testName=ai-astar) 05:56:22 INFO - 2015-11-05 05:56:22,818 DEBUG : BROWSER_OUTPUT: RSS: Main: 261902336 05:56:22 INFO - 2015-11-05 05:56:22,818 DEBUG : BROWSER_OUTPUT: 05:56:22 INFO - 2015-11-05 05:56:22,820 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:56:22 INFO - 2015-11-05 05:56:22,820 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:56:22 INFO - 2015-11-05 05:56:22,820 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:56:22 INFO - 2015-11-05 05:56:22,820 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:56:22 INFO - 2015-11-05 05:56:22,820 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;102;111;109;110;120;110;117;112;115 05:56:22 INFO - 2015-11-05 05:56:22,820 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;133;156;173;143;165;165;145;183;144 05:56:22 INFO - 2015-11-05 05:56:22,820 DEBUG : BROWSER_OUTPUT: |2;audio-dft;166;178;185;183;182;189;192;183;182;179 05:56:22 INFO - 2015-11-05 05:56:22,820 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;74;86;120;74;74;78;79;128;74 05:56:22 INFO - 2015-11-05 05:56:22,821 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;96;96;140;97;100;99;137;100;99;134 05:56:22 INFO - 2015-11-05 05:56:22,821 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;117;131;137;132;131;131;130;130;131;125 05:56:22 INFO - 2015-11-05 05:56:22,821 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;138;137;149;143;143;143;141;137;143;142 05:56:22 INFO - 2015-11-05 05:56:22,821 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;111;121;123;127;117;121;122;121;119;117 05:56:22 INFO - 2015-11-05 05:56:22,821 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;61;65;64;65;67;69;71;77;69;70 05:56:22 INFO - 2015-11-05 05:56:22,821 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;73;74;71;73;75;76;76;77;77;76 05:56:22 INFO - 2015-11-05 05:56:22,821 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;90;96;99;98;100;98;99;98;97;98 05:56:22 INFO - 2015-11-05 05:56:22,821 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;140;139;146;149;150;152;146;149;159;148 05:56:22 INFO - 2015-11-05 05:56:22,821 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;163;158;169;169;173;170;171;161;168;173 05:56:22 INFO - 2015-11-05 05:56:22,821 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;71;75;77;80;78;81;82;83;79 05:56:22 INFO - 2015-11-05 05:56:22,821 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:56:22 INFO - 2015-11-05 05:56:22,821 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:56:22 INFO - 2015-11-05 05:56:22,821 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,703 05:56:22 INFO - 2015-11-05 05:56:22,821 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:56:22 INFO - 2015-11-05 05:56:22,822 DEBUG : BROWSER_OUTPUT: __startTimestamp1446731782818__endTimestamp 05:56:22 INFO - 2015-11-05 05:56:22,822 DEBUG : BROWSER_OUTPUT: 05:56:22 INFO - 2015-11-05 05:56:22,825 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:56:22 INFO - 2015-11-05 05:56:22,825 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:56:22 INFO - 2015-11-05 05:56:22,825 DEBUG : BROWSER_OUTPUT: 05:56:22 INFO - 2015-11-05 05:56:22,826 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.50 Median:111.50 stddev:4.97 (4.5%) stddev-sans-first:5.19 05:56:22 INFO - 2015-11-05 05:56:22,826 DEBUG : BROWSER_OUTPUT: Values: 109.0 102.0 111.0 109.0 110.0 120.0 110.0 117.0 112.0 115.0 05:56:22 INFO - 2015-11-05 05:56:22,826 DEBUG : BROWSER_OUTPUT: 05:56:22 INFO - 2015-11-05 05:56:22,826 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:156.00 Median:160.50 stddev:15.46 (9.6%) stddev-sans-first:16.36 05:56:22 INFO - 2015-11-05 05:56:22,826 DEBUG : BROWSER_OUTPUT: Values: 153.0 133.0 156.0 173.0 143.0 165.0 165.0 145.0 183.0 144.0 05:56:22 INFO - 2015-11-05 05:56:22,826 DEBUG : BROWSER_OUTPUT: 05:56:22 INFO - 2015-11-05 05:56:22,827 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:181.90 Median:183.00 stddev:7.00 (3.8%) stddev-sans-first:4.47 05:56:22 INFO - 2015-11-05 05:56:22,827 DEBUG : BROWSER_OUTPUT: Values: 166.0 178.0 185.0 183.0 182.0 189.0 192.0 183.0 182.0 179.0 05:56:22 INFO - 2015-11-05 05:56:22,827 DEBUG : BROWSER_OUTPUT: 05:56:22 INFO - 2015-11-05 05:56:22,827 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:86.00 Median:74.00 stddev:20.49 (27.7%) stddev-sans-first:21.18 05:56:22 INFO - 2015-11-05 05:56:22,827 DEBUG : BROWSER_OUTPUT: Values: 73.0 74.0 86.0 120.0 74.0 74.0 78.0 79.0 128.0 74.0 05:56:22 INFO - 2015-11-05 05:56:22,827 DEBUG : BROWSER_OUTPUT: 05:56:22 INFO - 2015-11-05 05:56:22,828 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:109.80 Median:96.00 stddev:18.88 (19.7%) stddev-sans-first:19.35 05:56:22 INFO - 2015-11-05 05:56:22,828 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 140.0 97.0 100.0 99.0 137.0 100.0 99.0 134.0 05:56:22 INFO - 2015-11-05 05:56:22,828 DEBUG : BROWSER_OUTPUT: 05:56:22 INFO - 2015-11-05 05:56:22,828 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:129.50 Median:131.00 stddev:5.25 (4.0%) stddev-sans-first:3.06 05:56:22 INFO - 2015-11-05 05:56:22,828 DEBUG : BROWSER_OUTPUT: Values: 117.0 131.0 137.0 132.0 131.0 131.0 130.0 130.0 131.0 125.0 05:56:22 INFO - 2015-11-05 05:56:22,828 DEBUG : BROWSER_OUTPUT: 05:56:22 INFO - 2015-11-05 05:56:22,829 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:141.60 Median:143.00 stddev:3.63 (2.5%) stddev-sans-first:3.61 05:56:22 INFO - 2015-11-05 05:56:22,829 DEBUG : BROWSER_OUTPUT: Values: 138.0 137.0 149.0 143.0 143.0 143.0 141.0 137.0 143.0 142.0 05:56:22 INFO - 2015-11-05 05:56:22,829 DEBUG : BROWSER_OUTPUT: 05:56:22 INFO - 2015-11-05 05:56:22,829 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:119.90 Median:121.00 stddev:4.28 (3.5%) stddev-sans-first:3.10 05:56:22 INFO - 2015-11-05 05:56:22,829 DEBUG : BROWSER_OUTPUT: Values: 111.0 121.0 123.0 127.0 117.0 121.0 122.0 121.0 119.0 117.0 05:56:22 INFO - 2015-11-05 05:56:22,829 DEBUG : BROWSER_OUTPUT: 05:56:22 INFO - 2015-11-05 05:56:22,829 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:67.80 Median:69.00 stddev:4.47 (6.5%) stddev-sans-first:4.00 05:56:22 INFO - 2015-11-05 05:56:22,829 DEBUG : BROWSER_OUTPUT: Values: 61.0 65.0 64.0 65.0 67.0 69.0 71.0 77.0 69.0 70.0 05:56:22 INFO - 2015-11-05 05:56:22,829 DEBUG : BROWSER_OUTPUT: 05:56:22 INFO - 2015-11-05 05:56:22,829 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:74.80 Median:76.00 stddev:1.99 (2.6%) stddev-sans-first:2.00 05:56:22 INFO - 2015-11-05 05:56:22,829 DEBUG : BROWSER_OUTPUT: Values: 73.0 74.0 71.0 73.0 75.0 76.0 76.0 77.0 77.0 76.0 05:56:22 INFO - 2015-11-05 05:56:22,829 DEBUG : BROWSER_OUTPUT: 05:56:22 INFO - 2015-11-05 05:56:22,830 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:97.30 Median:98.00 stddev:2.79 (2.8%) stddev-sans-first:1.17 05:56:22 INFO - 2015-11-05 05:56:22,830 DEBUG : BROWSER_OUTPUT: Values: 90.0 96.0 99.0 98.0 100.0 98.0 99.0 98.0 97.0 98.0 05:56:22 INFO - 2015-11-05 05:56:22,830 DEBUG : BROWSER_OUTPUT: 05:56:22 INFO - 2015-11-05 05:56:22,830 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:147.80 Median:149.00 stddev:5.73 (3.8%) stddev-sans-first:5.34 05:56:22 INFO - 2015-11-05 05:56:22,830 DEBUG : BROWSER_OUTPUT: Values: 140.0 139.0 146.0 149.0 150.0 152.0 146.0 149.0 159.0 148.0 05:56:22 INFO - 2015-11-05 05:56:22,830 DEBUG : BROWSER_OUTPUT: 05:56:22 INFO - 2015-11-05 05:56:22,830 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.50 Median:169.50 stddev:5.13 (3.0%) stddev-sans-first:5.17 05:56:22 INFO - 2015-11-05 05:56:22,830 DEBUG : BROWSER_OUTPUT: Values: 163.0 158.0 169.0 169.0 173.0 170.0 171.0 161.0 168.0 173.0 05:56:22 INFO - 2015-11-05 05:56:22,830 DEBUG : BROWSER_OUTPUT: 05:56:22 INFO - 2015-11-05 05:56:22,830 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.50 Median:79.50 stddev:4.62 (5.8%) stddev-sans-first:3.75 05:56:22 INFO - 2015-11-05 05:56:22,830 DEBUG : BROWSER_OUTPUT: Values: 69.0 71.0 75.0 77.0 80.0 78.0 81.0 82.0 83.0 79.0 05:56:22 INFO - 2015-11-05 05:56:22,830 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:56:22 INFO - 2015-11-05 05:56:22,830 DEBUG : BROWSER_OUTPUT: 05:56:23 INFO - 2015-11-05 05:56:23,523 INFO : Browser exited with error code: 0 05:56:23 INFO - 2015-11-05 05:56:23,574 INFO : Completed test kraken (00:00:59) 05:56:23 INFO - 2015-11-05 05:56:23,575 INFO : Starting test v8_7 05:56:23 INFO - 2015-11-05 05:56:23,575 DEBUG : operating with platform_type : mac_ 05:56:23 INFO - 2015-11-05 05:56:23,575 INFO : Initialising browser for v8_7 test... 05:56:23 INFO - 2015-11-05 05:56:23,589 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/tmpn2e5As/profile http://localhost:49261/getInfo.html 05:56:26 INFO - 2015-11-05 05:56:26,464 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:56:26 INFO - 2015-11-05 05:56:26,464 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:56:26 INFO - 2015-11-05 05:56:26,464 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:56:26 INFO - 2015-11-05 05:56:26,465 DEBUG : BROWSER_OUTPUT: __metrics 05:56:27 INFO - 2015-11-05 05:56:27,124 INFO : Browser initialized. 05:56:27 INFO - 2015-11-05 05:56:27,124 INFO : Running cycle 1/1 for v8_7 test... 05:56:27 INFO - 2015-11-05 05:56:27,124 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/tmpn2e5As/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:56:39 INFO - 2015-11-05 05:56:39,118 DEBUG : BROWSER_OUTPUT: RSS: Main: 233390080 05:56:39 INFO - 2015-11-05 05:56:39,118 DEBUG : BROWSER_OUTPUT: 05:57:00 INFO - 2015-11-05 05:57:00,604 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/v8_7/run.html (next: http://localhost:49261/tests/v8_7/run.html) 05:57:00 INFO - 2015-11-05 05:57:00,861 DEBUG : BROWSER_OUTPUT: RSS: Main: 254529536 05:57:00 INFO - 2015-11-05 05:57:00,861 DEBUG : BROWSER_OUTPUT: 05:57:00 INFO - 2015-11-05 05:57:00,861 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:57:00 INFO - 2015-11-05 05:57:00,862 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:57:00 INFO - 2015-11-05 05:57:00,862 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:57:00 INFO - 2015-11-05 05:57:00,862 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:57:00 INFO - 2015-11-05 05:57:00,862 DEBUG : BROWSER_OUTPUT: |0;Richards;166.72224074691565 05:57:00 INFO - 2015-11-05 05:57:00,862 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;202.75750202757501 05:57:00 INFO - 2015-11-05 05:57:00,862 DEBUG : BROWSER_OUTPUT: |2;Encrypt;346.38032559750604 05:57:00 INFO - 2015-11-05 05:57:00,862 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6103.658536585366 05:57:00 INFO - 2015-11-05 05:57:00,863 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1184.8341232227488 05:57:00 INFO - 2015-11-05 05:57:00,863 DEBUG : BROWSER_OUTPUT: |5;Earley;843.1703204047218 05:57:00 INFO - 2015-11-05 05:57:00,863 DEBUG : BROWSER_OUTPUT: |6;Boyer;13916.666666666666 05:57:00 INFO - 2015-11-05 05:57:00,863 DEBUG : BROWSER_OUTPUT: |7;RegExp;30787.878787878788 05:57:00 INFO - 2015-11-05 05:57:00,863 DEBUG : BROWSER_OUTPUT: |8;Splay;714.7962830593281 05:57:00 INFO - 2015-11-05 05:57:00,863 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6147.239263803681 05:57:00 INFO - 2015-11-05 05:57:00,863 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:57:00 INFO - 2015-11-05 05:57:00,863 DEBUG : BROWSER_OUTPUT: __startTimestamp1446731820856__endTimestamp 05:57:00 INFO - 2015-11-05 05:57:00,864 DEBUG : BROWSER_OUTPUT: 05:57:00 INFO - 2015-11-05 05:57:00,864 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:57:00 INFO - 2015-11-05 05:57:00,864 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:57:00 INFO - 2015-11-05 05:57:00,864 DEBUG : BROWSER_OUTPUT: 05:57:00 INFO - 2015-11-05 05:57:00,864 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.72 Median:166.72 stddev:0.00 (0.0%) 05:57:00 INFO - 2015-11-05 05:57:00,864 DEBUG : BROWSER_OUTPUT: Values: 166.7 05:57:00 INFO - 2015-11-05 05:57:00,864 DEBUG : BROWSER_OUTPUT: 05:57:00 INFO - 2015-11-05 05:57:00,864 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:202.76 Median:202.76 stddev:0.00 (0.0%) 05:57:00 INFO - 2015-11-05 05:57:00,864 DEBUG : BROWSER_OUTPUT: Values: 202.8 05:57:00 INFO - 2015-11-05 05:57:00,864 DEBUG : BROWSER_OUTPUT: 05:57:00 INFO - 2015-11-05 05:57:00,865 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:346.38 Median:346.38 stddev:0.00 (0.0%) 05:57:00 INFO - 2015-11-05 05:57:00,865 DEBUG : BROWSER_OUTPUT: Values: 346.4 05:57:00 INFO - 2015-11-05 05:57:00,865 DEBUG : BROWSER_OUTPUT: 05:57:00 INFO - 2015-11-05 05:57:00,865 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6103.66 Median:6103.66 stddev:0.00 (0.0%) 05:57:00 INFO - 2015-11-05 05:57:00,865 DEBUG : BROWSER_OUTPUT: Values: 6103.7 05:57:00 INFO - 2015-11-05 05:57:00,865 DEBUG : BROWSER_OUTPUT: 05:57:00 INFO - 2015-11-05 05:57:00,865 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1184.83 Median:1184.83 stddev:0.00 (0.0%) 05:57:00 INFO - 2015-11-05 05:57:00,865 DEBUG : BROWSER_OUTPUT: Values: 1184.8 05:57:00 INFO - 2015-11-05 05:57:00,866 DEBUG : BROWSER_OUTPUT: 05:57:00 INFO - 2015-11-05 05:57:00,866 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:843.17 Median:843.17 stddev:0.00 (0.0%) 05:57:00 INFO - 2015-11-05 05:57:00,866 DEBUG : BROWSER_OUTPUT: Values: 843.2 05:57:00 INFO - 2015-11-05 05:57:00,866 DEBUG : BROWSER_OUTPUT: 05:57:00 INFO - 2015-11-05 05:57:00,866 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:13916.67 Median:13916.67 stddev:0.00 (0.0%) 05:57:00 INFO - 2015-11-05 05:57:00,866 DEBUG : BROWSER_OUTPUT: Values: 13916.7 05:57:00 INFO - 2015-11-05 05:57:00,866 DEBUG : BROWSER_OUTPUT: 05:57:00 INFO - 2015-11-05 05:57:00,867 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:30787.88 Median:30787.88 stddev:0.00 (0.0%) 05:57:00 INFO - 2015-11-05 05:57:00,867 DEBUG : BROWSER_OUTPUT: Values: 30787.9 05:57:00 INFO - 2015-11-05 05:57:00,867 DEBUG : BROWSER_OUTPUT: 05:57:00 INFO - 2015-11-05 05:57:00,867 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:714.80 Median:714.80 stddev:0.00 (0.0%) 05:57:00 INFO - 2015-11-05 05:57:00,867 DEBUG : BROWSER_OUTPUT: Values: 714.8 05:57:00 INFO - 2015-11-05 05:57:00,867 DEBUG : BROWSER_OUTPUT: 05:57:00 INFO - 2015-11-05 05:57:00,867 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6147.24 Median:6147.24 stddev:0.00 (0.0%) 05:57:00 INFO - 2015-11-05 05:57:00,867 DEBUG : BROWSER_OUTPUT: Values: 6147.2 05:57:00 INFO - 2015-11-05 05:57:00,868 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:57:00 INFO - 2015-11-05 05:57:00,868 DEBUG : BROWSER_OUTPUT: 05:57:01 INFO - 2015-11-05 05:57:01,532 INFO : Browser exited with error code: 0 05:57:01 INFO - 2015-11-05 05:57:01,554 INFO : Completed test v8_7 (00:00:37) 05:57:01 INFO - 2015-11-05 05:57:01,955 INFO : Completed test suite (00:20:08) 05:57:01 INFO - 2015-11-05 05:57:01,955 DEBUG : Working with test: dromaeo_css 05:57:01 INFO - 2015-11-05 05:57:01,955 DEBUG : Generating results file: dromaeo_css 05:57:01 INFO - 2015-11-05 05:57:01,956 DEBUG : Working with test: kraken 05:57:01 INFO - 2015-11-05 05:57:01,956 DEBUG : Generating results file: kraken 05:57:01 INFO - 2015-11-05 05:57:01,956 INFO : javascript benchmark 05:57:01 INFO - 2015-11-05 05:57:01,956 DEBUG : Working with test: v8_7 05:57:01 INFO - 2015-11-05 05:57:01,956 DEBUG : Generating results file: v8_7 05:57:01 INFO - 2015-11-05 05:57:01,956 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:57:02 INFO - 2015-11-05 05:57:02,016 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,57]] 05:57:02 INFO - 2015-11-05 05:57:02,016 DEBUG : process_Request line: dromaeo_css 6020.49 graph.html#tests=[[72,64,57]] 05:57:02 INFO - 2015-11-05 05:57:02,016 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:57:02 INFO - 2015-11-05 05:57:02,128 DEBUG : process_Request line: kraken 1668.90 graph.html#tests=[[232,64,57]] 05:57:02 INFO - 2015-11-05 05:57:02,128 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:57:02 INFO - 2015-11-05 05:57:02,242 DEBUG : process_Request line: v8_7 18490.33 graph.html#tests=[[230,64,57]] 05:57:02 INFO - 2015-11-05 05:57:02,243 INFO : javascript benchmark 05:57:02 INFO - 2015-11-05 05:57:02,245 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [306.75153125967967, 307.5893681934617, 313.2044606698983, 318.1299146833411, 323.936832317698, 10978.396188209645, 11436.256643318178, 16300.429484968014, 16702.415415460462, 16933.0, 10873.619423320166, 10996.0, 11006.229563930528, 11024.283421577611, 11102.167337449684, 4012.699047571429, 4169.207850508409, 4170.624643782059, 4176.7076304658685, 4181.540030596647, 3989.8603548875794, 4070.5725898780647, 4111.691623128262, 4114.033202197481, 4177.51958524769, 4034.7579145251234, 4097.3853921911805, 4136.751794892316, 4205.327147656376, 4281.785910704468, 4279.0799978004725, 4285.550017248175, 4285.8071386787515, 4293.656507479394, 4305.246581848164, 3550.8757193498363, 3561.4301711726, 3578.481120237551, 3591.6587924147166, 3608.458731190316, 11895.345755983417, 12107.757844843141, 12136.87863121375, 12288.324142172178, 12321.75356492874, 1785.4018903667286, 1810.3030333321635, 1832.0428471258751, 1849.3619701203063, 1859.6745569525278, 8963.417377870417, 9052.637894484213, 9075.773105672344, 9080.909190908073, 9162.267018638493, 1413.6041908265702, 1430.6637940084072, 1446.7902154187689, 1462.2615579132575, 1536.6004838742008, 54926.72536637331, 56495.71752141213, 56518.0, 56961.430385696025, 57855.13217301744, 5983.700814959235, 5996.580239383288, 6089.208402907594, 6089.421504957022, 6176.8764624707255, 6902.206246281742, 6927.134108236471, 6978.092847929736, 6979.267176946449, 7003.719851205997, 4720.811167553259, 4750.881227969328, 4809.9038019240115, 4925.21196608541, 4992.425871024806, 5117.462666419972, 5125.051865404912, 5133.383993920754, 5151.304573882553, 5206.895862082737, 2682.9597556036674, 2697.1234348836706, 2713.9050133245637, 2721.034032918325, 2727.0864260472963, 973.3673112476947, 977.6822532676766, 979.1334668818005, 981.3719219699398, 1032.6747074671455, 362.2899117729228, 364.16605972323083, 373.4510269903238, 377.1269511081837, 384.26413418304196, 9246.876122799255, 9506.239500839916, 9601.47191904452, 9749.220062394992, 10357.22320825926, 374.6777771116837, 385.6432799660303, 393.8168751530552, 394.4773175542418, 397.85478300420715, 5252.842414727565, 5411.026015317202, 5425.186222066643, 5496.7526461309335, 5527.50252477279, 486564.0, 488983.0, 491055.0, 493791.0, 499904.0, 61489.999999999105, 64240.678796605716, 66182.33817661762, 67231.66384168048, 68212.0, 451.652227784604, 456.0696179793251, 466.1771972468596, 474.3975151557503, 477.7969363020702, 9943.801123977335, 10159.288849780445, 10188.694339169837, 10205.438700871226, 10254.846177307496, 29686.257843554085, 31315.21711957128, 31674.68325316717, 32317.0, 33123.66876331206, 40673.1865362697, 41710.0, 42404.57595424006, 42459.78770106253, 42809.0, 5482.725863706878, 5578.721063946868, 5671.914921276267, 5732.9680657480385, 5786.3056433228285, 10307.94846025765, 10886.945565272123, 10979.17656175774, 10980.615678451215, 11010.779784404427, 9113.635454581743, 9221.262299016196, 9358.766030849283, 9380.953095234754, 9471.10024547667, 8962.238209752244, 9109.316801239802, 9218.585163667785, 9253.306002049738, 9388.812223755624, 9215.078492150731, 9449.905500945177, 9847.556859941464, 9881.85177222328, 9937.055979681918, 5433.864153396196, 5709.600327977168, 5731.627444216113, 5771.769129234784, 5803.506701930383, 9133.543322833964, 9221.723348299562, 9412.058794120534, 9427.670031548863, 9518.190953769008], "dojo.html": [2989.5964044853968, 2993.2068001979464, 2998.235449960261, 3167.1765341011346, 3168.572242747229, 4884.560389564938, 4943.332650092237, 4970.900581988358, 4971.328870602468, 5014.824481143151, 4797.448293446255, 4813.8796530086765, 4857.392825896763, 4948.183549714293, 4987.526185012427, 4548.681592288541, 4552.157850797613, 4600.332951721998, 4634.37435946148, 4731.455882573497, 25.20118782921532, 4546.8408605698805, 4603.861884143481, 4631.189541830183, 4673.112108699336, 4555.4533455985165, 4582.656300777455, 4598.103369842882, 4604.7927843247135, 4618.284165954283, 4546.522615125397, 4606.378138951266, 4606.424196975378, 4613.7923793429045, 4642.141203877293, 4345.587169218919, 4495.370648109268, 4504.09918016398, 4583.358329833826, 4625.699329543602, 4633.235516139833, 4848.5636292733825, 4862.17343051682, 4910.140725373046, 4992.276119962585, 5098.7705553249825, 5190.662606930575, 5212.244224587452, 5222.216667499867, 5245.1869960155855, 5153.175491921274, 5235.790568377261, 5252.369715634149, 5324.148136298212, 5356.625036247464, 4904.386951631046, 4917.852464426037, 4968.180250258703, 4973.626977976703, 4985.90028199434, 5319.973400132974, 5395.595330350239, 5462.180672899018, 5465.836024919259, 5480.945190548123, 5011.273365362002, 5036.546710796046, 5076.0, 5090.643654944192, 5153.948460515422, 5276.3932147802725, 5286.550643195372, 5310.495502927216, 5351.983123206578, 5375.731213439312, 5054.545090941833, 5213.869653258623, 5221.242919776687, 5260.13207820713, 5285.418603953562, 5113.284140220372, 5124.461931497139, 5186.792528298825, 5193.1171700810955, 5223.791048358099, 4031.1937612477623, 4043.7978101095414, 4059.330210515232, 4134.049168691218, 4141.482314710661, 3630.5824830144343, 3692.7230457715777, 3715.7398982070995, 3739.7195210358786, 3828.253490569368, 4877.707337559757, 4886.242632391985, 4931.58081563064, 4995.400551933792, 5015.924761128586, 5272.841814745564, 5321.467853214725, 5327.227552005015, 5387.218853266333, 5400.540954018874, 4821.63837712173, 4920.655554111249, 5004.699718016931, 5021.422536408287, 5024.472430394756, 4689.085628302517, 4690.061987602493, 4696.882577935579, 4702.6473014524045, 4773.76131193439, 5416.485433883775, 5425.565954723534, 5469.234307196995, 5472.015037293246, 5486.231927530149, 5224.555912747307, 5323.228131920772, 5344.679319240858, 5358.732063396893, 5385.461453854583, 5317.7341132943975, 5381.11211650089, 5383.08487557124, 5438.184272359178, 5441.29263195782, 5246.711430871339, 5263.0, 5276.683398996072, 5285.788568457218, 5299.655522391032, 5137.563307118937, 5203.089459344676, 5266.0, 5299.258103865539, 5421.783128674809, 5228.738563071755, 5270.657407268515, 5275.604329675213, 5277.050130976461, 5298.072837253389, 5045.84862454127, 5220.738963051908, 5278.868028299324, 5284.524392804666, 5310.495502927216, 5002.52476014778, 5038.546530812245, 5049.2173713074535, 5102.0, 5116.590672746246, 5037.596992240685, 5224.9738751306, 5234.731617958139, 5242.68543887368, 5245.160774276097, 4927.852164435073, 5072.721000345016, 5132.538071573427, 5149.7682604282145, 5159.993801208729], "mootools.html": [1462.5100591301914, 1572.811262648482, 1639.303296099158, 1654.9751753723697, 1661.244133919067, 6363.681815909197, 6537.411632953033, 6957.130358705162, 7190.604516751583, 7268.0, 6740.561863478871, 6992.6154061526595, 7073.575585464876, 7093.503454758169, 7098.148222213329, 2015.244283393731, 2031.3195079648335, 2033.888136152511, 2039.1537511932531, 2041.846861485387, 2029.8782073075588, 2060.8969551522437, 2067.586482703465, 2074.751029876417, 2075.1595603780415, 2008.3472871316808, 2055.7224774655456, 2088.926887558936, 2089.6552068908613, 2091.7699053104147, 1983.7421135252398, 1995.9002049897592, 2000.2699014859618, 2004.7794742578305, 2008.0963566395108, 2002.0890494824819, 2004.4387571480008, 2030.0864610924996, 2032.1871251499372, 2036.8268697160759, 7028.964855175743, 7058.0, 7138.321859423347, 7139.964300178518, 7164.247753985808, 4276.5295817460055, 4297.183535128315, 4351.782410879475, 4354.608085272309, 4370.606645401929, 2306.976930230693, 2371.8221133415063, 2597.8181527293095, 2665.7867370610306, 2665.973340266592, 779.9727009554638, 809.6963638635511, 811.5779794506824, 822.0628483528782, 824.0194168939004, 9080.364374493787, 9081.863772043358, 9136.954315228448, 9205.03347148553, 9271.490068046254, 3873.0704630888386, 3967.4247234150885, 4025.879223623296, 4065.4308396824467, 4070.2266569351727, 8003.359731221604, 8127.268545830903, 8133.877991830127, 8140.75577732669, 8141.552214628134, 4431.800568974404, 4469.642428605704, 4472.530384309601, 4473.530279320625, 4483.237849565582, 4047.170330082326, 4055.1078762672164, 4096.487939007624, 4100.302948498763, 4104.035551645361, 3351.0, 3390.5083762854247, 3418.2821607462215, 3426.9657303427143, 3434.5019972104405, 1029.3206483720708, 1040.1210976724656, 1044.3525014491065, 1059.3749687684303, 1060.7295139739317, 1185.1170877696172, 1195.49789088583, 1208.7582483503334, 1224.8468941382328, 1242.2484396939901, 6597.373249541286, 6615.17310336208, 6704.0, 6732.596044237362, 6749.358810912955, 402.95768944261016, 417.887170463973, 419.0571214766775, 419.2579134931155, 422.5837550013234, 5065.544101030925, 5099.847004589868, 5140.974295128501, 5145.536901678867, 5152.3044389007755, 7366.300201480851, 7689.538627682357, 7948.960255198803, 8030.638621262057, 8293.585320733939, 8154.613715668351, 8173.223543763452, 8236.876446853303, 8237.711680091288, 8264.380171487162, 6511.8697626047215, 6539.607623542603, 6606.471482281406, 6685.264620891698, 6700.463962882957, 6404.327545607644, 6464.0, 6475.579087359307, 6480.611163330215, 6492.220933488012, 7252.419806415369, 7318.414526837733, 7432.851342973218, 7555.395568354628, 7636.694532218649, 7561.281678240558, 7628.38972882157, 7715.112762032214, 7723.189065148304, 7730.574818385043, 6220.222472190976, 6240.063990401294, 6271.027990661455, 6272.560920735505, 6276.686165691788, 6745.5952642841585, 6807.625580592917, 6863.656817159222, 6885.931140688529, 6896.27589103137, 6315.052742088724, 6368.235811702625, 6387.489000879826, 6459.61242325462, 6481.0, 6212.937870621417, 6275.246970363585, 6286.088517164894, 6326.6520341381665, 6359.300476947439, 6331.27190373113, 6458.289588145394, 6470.38531339522, 6472.126262954441, 6480.449161821298, 5753.884922301614, 5822.184894114743, 5823.242978412779, 5831.562632802472, 5834.124881267844, 5877.617954832922, 5892.499137573354, 5965.701714914324, 5972.044472884318, 5998.310194327708], "ext.html": [507.188498402556, 518.5151882989404, 524.4048005513744, 542.0730550758202, 542.7530473634497, 36790.0, 37868.621313786854, 37872.81063594685, 37889.43165852514, 38001.619983800156, 39849.0, 40336.0, 40441.39337909934, 40532.39201411981, 40764.796176019154, 8481.533515656636, 8651.091635378289, 8659.69691060813, 8679.349048821332, 8755.474671519698, 8466.576671166447, 8570.82858342836, 8591.785205369853, 8595.097514760953, 8665.566721663923, 8153.836923261531, 8487.236148746611, 8574.957125214396, 8578.313734901192, 8666.39335246533, 8566.48601083937, 8567.143285671445, 8585.570721463902, 8664.783380415509, 8697.913020869773, 8386.706465273686, 8429.70496032642, 8510.659573617047, 8525.232729054353, 8537.829243415097, 36853.815730921444, 36857.44713829295, 36921.26157476862, 37308.0, 37317.44023839645, 2412.2039726890084, 2528.471725211227, 2614.712381638018, 2896.9130926072253, 2913.6357955255594, 24571.87714061436, 24957.376065598324, 25341.87329063361, 25921.0, 26142.477150457074, 2217.8780167090804, 2248.977510224893, 2251.5609456156058, 2256.9661455078185, 2290.7594702556157, 242873.0, 243399.0, 245544.0, 246104.0, 246761.0, 39181.60818391779, 39399.21201575953, 39493.605063949566, 39742.20515589672, 52100.21849672258, 40161.799191003855, 40742.0, 40834.59165408367, 41210.58789412127, 41285.79357103195, 12642.494300228072, 12676.619701408972, 12823.0, 12925.095243333064, 12972.935135324264, 9904.059114384121, 9966.651167209258, 9976.80046399068, 10134.23993200513, 10170.949145254226, 12886.742265154644, 13141.868581314257, 13181.209127452383, 13191.472341106248, 13261.469541218436, 5864.6834500372115, 5888.0, 6005.549583781234, 6005.558665920235, 6030.095485677183, 891.6299735609779, 894.7763059235191, 911.0434044253508, 1011.3830563356347, 1093.1691914145306, 26633.33416664599, 26817.463650726877, 26845.194644160707, 26897.86551067232, 26903.461930761274, 1008.4856723071287, 1020.0666390252984, 1021.5505177721927, 1026.7330494071596, 1119.5074167366333, 13833.378776987174, 13961.0, 14041.1575305482, 14074.507392241223, 14111.0, 285615.0, 290067.0, 290937.0, 292207.0, 293022.0, 50773.95356278635, 51423.97152056938, 51893.0, 51954.74022629863, 52322.47677523252, 1265.6139877337316, 1290.748304080714, 1298.2535042350687, 1309.1294289297512, 1312.3831799054428, 26204.868975655, 27006.0, 27037.324066898484, 27232.455350893266, 29547.261318467212, 48721.0, 49451.752741237506, 49510.0, 49930.75034624804, 50391.74804125956, 258449.0, 260442.0, 260501.0, 261318.0, 263187.0, 39394.60605394024, 40003.39994900021, 41076.79461602673, 42713.78643106889, 43215.0, 39318.6186126693, 40100.19799603933, 40632.39051414172, 41066.79466602648, 41130.79434602808, 33137.171570710925, 33736.0, 34249.0, 34267.828660857536, 34403.0, 33219.0, 33324.166895827795, 33407.84799009992, 33519.664803351654, 33941.66058339385, 33913.49129763006, 34175.0, 34444.0, 34663.0, 35046.82476587601, 29465.705342946298, 29702.257443564085, 29823.25441863884, 30106.69893301039, 30256.243593909447, 22788.202412915467, 22961.196358127385, 23091.076356945534, 23251.3024609262, 23329.76670233344], "prototype.html": [292.3962018431938, 295.9274977630481, 299.5626385477203, 301.6289963345086, 303.1678043769852, 5749.396313387097, 5821.592488525805, 5821.9999999999945, 5892.793752218673, 5910.3203131639875, 5673.631213971089, 5683.318001839774, 5731.684757338345, 5772.393898640635, 5776.480116789488, 4333.891652708676, 4389.890252743675, 4398.670099742516, 4429.579189976963, 4460.910781784362, 4373.825046998117, 4374.300111982084, 4405.140997505488, 4414.845480408187, 4439.8446054388105, 4340.609345158935, 4342.956570434302, 4344.413504176927, 4377.190219809346, 4385.978070109645, 4227.957720422787, 4343.326784348431, 4344.89137771555, 4347.804348804311, 4394.560543945596, 3742.5696044954907, 3746.981265093684, 3749.737518373715, 3760.52993375828, 3763.1344790698017, 5506.421825708283, 5571.832845014656, 5619.409961953977, 5653.971730141323, 5665.66006039639, 4903.583195428393, 4943.036107958949, 4946.084974279734, 4950.0, 4953.5541801237705, 5991.850203744898, 5997.8800423991715, 5998.910016349758, 6042.456178943872, 6055.515558755289, 3987.142764305688, 4031.5565287818317, 4059.8579049733116, 4085.44846445729, 4094.28350038742, 6264.154339164245, 6329.398707122816, 6331.2085989251345, 6358.713857876361, 6362.331955144689, 4222.59885310895, 4229.830806767756, 4237.660987121023, 4239.936400953989, 4260.275753121977, 4268.445102136764, 4302.698811083257, 4330.0, 4334.371516130143, 4335.6965012449455, 4846.36997190363, 4975.676581022222, 4982.750862456863, 4983.953369792384, 4988.276699878497, 6037.305709843425, 6050.878982420327, 6075.453209211104, 6079.604825686405, 6102.664353460602, 1516.9014014089048, 1534.087218105248, 1553.3864123671312, 1556.820965588949, 1558.2286768049887, 987.3976874106789, 988.3476905242505, 1015.8984101589782, 1022.8363461846069, 1039.34521251611, 5828.825135245949, 5862.443067908627, 5866.5893387462465, 5895.734691938873, 5904.0553511437965, 6265.467435268053, 6270.968645156745, 6307.905381419282, 6309.179806625109, 6309.369063093745, 5874.118882167623, 5880.0297950838485, 5882.941170588239, 5901.0, 5927.1405646181065, 3351.3464874349756, 3448.706859916885, 3478.0261526772542, 3482.233908540117, 3482.460218666111, 6258.9374106259265, 6404.199475065617, 6429.453496452854, 6466.902996455057, 6476.967615161988, 6389.169407977026, 6439.678016099177, 6451.870962580722, 6508.121403610452, 6546.672666366662, 6373.362663733589, 6394.360563943568, 6395.808125756234, 6425.742970281136, 6462.289148193601, 6110.114033465212, 6281.246250449975, 6285.0, 6296.5592408530965, 6300.054991751274, 6140.723667435065, 6156.199694039746, 6173.228346456693, 6277.780277690259, 6319.747210111728, 6452.354764523698, 6453.967730161319, 6455.903161452488, 6456.870047741532, 6519.7392104315295, 4090.9795451022555, 4128.0, 4132.111596006873, 4135.77253251074, 4145.8963525912095, 6139.508839292936, 6278.309385967448, 6336.683165841781, 6407.231132264158, 6418.326075761977, 6164.660943647963, 6186.659733714689, 6191.133241346305, 6217.689115544295, 6219.160413344141, 6029.879402412015, 6072.787452439144, 6103.969480152571, 6146.877062458636, 6183.907241391473, 5843.094320380348, 5968.820935371946, 6000.51995840323, 6003.549733769897, 6036.607620504653, 6111.694415279308, 6154.876902462015, 6187.041008643668, 6189.96905015472, 6265.0, 6063.969680151571, 6069.575129740876, 6086.6652334122045, 6089.48239399656, 6100.664463454553], "yui.html": [677.2211956250311, 697.5047716121557, 718.5832217313958, 724.4530379563429, 724.7716969154716, 12971.156874803142, 13218.60344189676, 13318.13432126911, 13383.464661413533, 13417.12788668737, 12904.548340808074, 13128.212307261547, 13187.208767473958, 13248.470061197564, 13275.0, 822.8642274024779, 827.1604321613552, 834.9332053435711, 837.6649340263882, 844.7212419901449, 821.4126899267023, 827.9130691277419, 833.8992529860557, 842.2546046748611, 842.3598065470256, 856.2379482260793, 856.2935578148022, 858.8582883824192, 866.1684782608703, 866.1901122450497, 854.0647990450478, 856.3919617071887, 858.4548811504708, 859.1151114352227, 862.1680078723999, 629.116091890894, 629.4303655192059, 629.9559030867841, 630.0675000998502, 630.5239544144142, 12657.0, 12797.48810047597, 12836.229826210458, 12852.421641026176, 13010.219386836725, 8797.736067917973, 8893.866592001124, 8950.507722075283, 8992.8651070234, 9332.766680832965, 8385.916140838635, 8504.914950850536, 8522.360822938243, 8572.785680357978, 8643.481391116553, 2761.654793150856, 2764.8755805988576, 2823.026056010673, 2838.4181242845166, 2897.0729366602695, 43210.135797284194, 43216.0, 43462.13075738467, 43837.34243986343, 43873.78063109664, 5917.112433135064, 6064.545159113084, 6090.817275481742, 6266.780662676784, 6541.247756507967, 10927.3989930553, 11055.72360690989, 11098.389588572705, 11105.278156919774, 11113.0, 5725.1698503716725, 5736.368999410061, 5878.441548052928, 5966.075258334965, 6005.6396616203165, 3475.58293004841, 3532.6643968822923, 3577.373959557067, 3617.9276414472088, 3649.1424515238896, 2466.8273220874366, 2496.1388321029217, 2496.6504689343506, 2511.8869650865754, 2512.899484020655, 353.05029470723673, 356.4706410979693, 358.78652201939803, 361.308094998081, 365.532118887824, 424.7663784918344, 535.1090434426636, 551.2585572405109, 560.4927540575785, 565.9122835960433, 7454.589997550078, 7458.276850044956, 7571.659275332623, 7720.575368354795, 7723.729669461542, 458.45443921733033, 468.28352620490705, 495.03715273792847, 578.2165166199823, 584.2200662116038, 3468.722502199818, 3542.946855797165, 3602.3335682898746, 3682.0610744260043, 3685.7972811495624, 57780.0, 58186.709066454394, 58371.0, 58492.70753646205, 58842.41157588369, 49427.752861235465, 50006.74996624994, 50051.49948500541, 50191.498085018684, 50414.495855041714, 45619.77190114028, 45817.0, 46240.3063954041, 46278.537214627424, 46449.0, 7198.49610527258, 7202.603856787927, 7369.963150184215, 7374.188839227573, 7402.29678180572, 33518.664813351555, 33868.0, 34259.314813704084, 34359.828200858836, 34635.30729385449, 40835.79582102071, 42017.78991105025, 44865.77567112144, 45034.3244851334, 46203.0, 6242.563020588515, 6359.87280254383, 6549.279579246184, 6826.419754320938, 6902.516823822284, 9426.619132501593, 9534.332596718163, 9595.328327017041, 9831.803363932824, 10215.029572190928, 8796.956015219883, 8896.86654700193, 9110.225630821455, 9494.905050949403, 9523.23826090426, 9145.222656074307, 9362.391444556082, 9414.717558473258, 9463.905360946577, 9737.805243895224, 8721.912780872364, 8850.114988501098, 9089.272858171198, 9131.178193962574, 9457.621695132118, 7816.57008864518, 7856.5678887661725, 8023.719169829262, 8042.9597852010365, 8555.144485551395, 7608.467407281437, 7614.238576142341, 8395.286400655768, 8396.958015209884, 8728.56357182151]}, "summary": {"suite": 6020.488694781762, "subtests": {"jquery.html": {"filtered": 6003.964744898145, "value": 6003.964744898145}, "dojo.html": {"filtered": 4863.951094765491, "value": 4863.951094765491}, "mootools.html": {"filtered": 3963.786867677928, "value": 3963.786867677928}, "ext.html": {"filtered": 16696.160630950017, "value": 16696.160630950017}, "prototype.html": {"filtered": 4567.29360472281, "value": 4567.29360472281}, "yui.html": {"filtered": 5394.3277424026755, "value": 5394.3277424026755}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0097.e"}, "testrun": {"date": 1446730613, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151105031836", "branch": "Fx-Team", "revision": "bad16f7ef2ce7b0d2e87c384dd0cf9ef314156f5"}}, {"talos_counters": {}, "results": {"audio-dft": [166.0, 178.0, 185.0, 183.0, 182.0, 189.0, 192.0, 183.0, 182.0, 179.0], "ai-astar": [109.0, 102.0, 111.0, 109.0, 110.0, 120.0, 110.0, 117.0, 112.0, 115.0], "imaging-gaussian-blur": [117.0, 131.0, 137.0, 132.0, 131.0, 131.0, 130.0, 130.0, 131.0, 125.0], "audio-beat-detection": [153.0, 133.0, 156.0, 173.0, 143.0, 165.0, 165.0, 145.0, 183.0, 144.0], "json-stringify-tinderbox": [73.0, 74.0, 71.0, 73.0, 75.0, 76.0, 76.0, 77.0, 77.0, 76.0], "stanford-crypto-pbkdf2": [163.0, 158.0, 169.0, 169.0, 173.0, 170.0, 171.0, 161.0, 168.0, 173.0], "json-parse-financial": [61.0, 65.0, 64.0, 65.0, 67.0, 69.0, 71.0, 77.0, 69.0, 70.0], "stanford-crypto-sha256-iterative": [69.0, 71.0, 75.0, 77.0, 80.0, 78.0, 81.0, 82.0, 83.0, 79.0], "audio-fft": [73.0, 74.0, 86.0, 120.0, 74.0, 74.0, 78.0, 79.0, 128.0, 74.0], "imaging-darkroom": [138.0, 137.0, 149.0, 143.0, 143.0, 143.0, 141.0, 137.0, 143.0, 142.0], "stanford-crypto-ccm": [140.0, 139.0, 146.0, 149.0, 150.0, 152.0, 146.0, 149.0, 159.0, 148.0], "audio-oscillator": [96.0, 96.0, 140.0, 97.0, 100.0, 99.0, 137.0, 100.0, 99.0, 134.0], "stanford-crypto-aes": [90.0, 96.0, 99.0, 98.0, 100.0, 98.0, 99.0, 98.0, 97.0, 98.0], "imaging-desaturate": [111.0, 121.0, 123.0, 127.0, 117.0, 121.0, 122.0, 121.0, 119.0, 117.0]}, "summary": {"suite": 1668.8999999999999, "subtests": {"audio-fft": {"filtered": 86.0, "value": 86.0}, "stanford-crypto-pbkdf2": {"filtered": 167.5, "value": 167.5}, "audio-beat-detection": {"filtered": 156.0, "value": 156.0}, "stanford-crypto-ccm": {"filtered": 147.8, "value": 147.8}, "imaging-darkroom": {"filtered": 141.6, "value": 141.6}, "json-parse-financial": {"filtered": 67.8, "value": 67.8}, "audio-oscillator": {"filtered": 109.8, "value": 109.8}, "ai-astar": {"filtered": 111.5, "value": 111.5}, "audio-dft": {"filtered": 181.9, "value": 181.9}, "stanford-crypto-sha256-iterative": {"filtered": 77.5, "value": 77.5}, "json-stringify-tinderbox": {"filtered": 74.8, "value": 74.8}, "imaging-gaussian-blur": {"filtered": 129.5, "value": 129.5}, "stanford-crypto-aes": {"filtered": 97.3, "value": 97.3}, "imaging-desaturate": {"filtered": 119.9, "value": 119.9}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0097.e"}, "testrun": {"date": 1446730613, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151105031836", "branch": "Fx-Team", "revision": "bad16f7ef2ce7b0d2e87c384dd0cf9ef314156f5"}}, {"talos_counters": {}, "results": {"DeltaBlue": [202.75750202757501], "Encrypt": [346.38032559750604], "NavierStokes": [6147.239263803681], "Decrypt": [6103.658536585366], "Splay": [714.7962830593281], "Richards": [166.72224074691565], "RegExp": [30787.878787878788], "Earley": [843.1703204047218], "Boyer": [13916.666666666666], "RayTrace": [1184.8341232227488]}, "summary": {"suite": 18490.32659850164, "subtests": {"DeltaBlue": {"filtered": 326.093976, "value": 326.093976}, "Encrypt": {"filtered": 768.4645470000003, "value": 768.4645470000003}, "NavierStokes": {"filtered": 241.40918163672674, "value": 241.40918163672674}, "Decrypt": {"filtered": 43.61007392607391, "value": 43.61007392607391}, "Splay": {"filtered": 114.005909, "value": 114.005909}, "RegExp": {"filtered": 29.589079724409423, "value": 29.589079724409423}, "Richards": {"filtered": 211.74139599999998, "value": 211.74139599999998}, "Earley": {"filtered": 790.4251180000002, "value": 790.4251180000002}, "Boyer": {"filtered": 47.88955688622753, "value": 47.88955688622753}, "RayTrace": {"filtered": 624.5507160000001, "value": 624.5507160000001}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0097.e"}, "testrun": {"date": 1446730613, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151105031836", "branch": "Fx-Team", "revision": "bad16f7ef2ce7b0d2e87c384dd0cf9ef314156f5"}}] 05:57:02 INFO - RETURN: dromaeo_css: 6020.49 05:57:02 INFO - RETURN: kraken: 1668.90 05:57:02 INFO - RETURN: v8_7: 18490.33 05:57:02 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,57]]", "result": "18490.33"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,57]]", "result": "1668.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,57]]", "result": "6020.49"}}} 05:57:02 INFO - Return code: 0 05:57:02 INFO - # TBPL SUCCESS # 05:57:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:57:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:57:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:57:02 INFO - 2015-11-05 05:57:02.373 screenresolution[1664:10696] starting screenresolution argv=screenresolution get 05:57:02 INFO - 2015-11-05 05:57:02.376 screenresolution[1664:10696] Display 0: 1600x1200x32@60 05:57:02 INFO - 2015-11-05 05:57:02.383 screenresolution[1665:10699] starting screenresolution argv=screenresolution list 05:57:02 INFO - Available Modes on Display 0 05:57:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:57:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:57:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:57:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:57:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:57:02 INFO - Intel HD Graphics 3000: 05:57:02 INFO - Chipset Model: Intel HD Graphics 3000 05:57:02 INFO - Type: GPU 05:57:02 INFO - Bus: Built-In 05:57:02 INFO - VRAM (Total): 512 MB 05:57:02 INFO - VRAM (Dynamic, Max): 10 05:57:02 INFO - Vendor: Intel (0x8086) 05:57:02 INFO - Device ID: 0x0116 05:57:02 INFO - Revision ID: 0x0009 05:57:02 INFO - Displays: 05:57:02 INFO - Display: 05:57:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:57:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:57:02 INFO - Display Serial Number: 1600x1200 60 05:57:02 INFO - Main Display: Yes 05:57:02 INFO - Mirror: Off 05:57:02 INFO - Online: Yes 05:57:02 INFO - Rotation: Supported 05:57:02 INFO - Return code: 0 05:57:02 INFO - Running post-action listener: _resource_record_post_action 05:57:02 INFO - Running post-run listener: _resource_record_post_run 05:57:03 INFO - Total resource usage - Wall time: 1248s; CPU: 30.0%; Read bytes: 40104960; Write bytes: 692008960; Read time: 4877; Write time: 69751 05:57:03 INFO - install - Wall time: 39s; CPU: 30.0%; Read bytes: 335524352; Write bytes: 336470016; Read time: 33570; Write time: 7025 05:57:03 INFO - run-tests - Wall time: 1210s; CPU: 30.0%; Read bytes: 39085056; Write bytes: 344301568; Read time: 4300; Write time: 62173 05:57:03 INFO - Running post-run listener: _upload_blobber_files 05:57:03 INFO - Blob upload gear active. 05:57:03 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:57:03 INFO - Copying logs to upload dir... 05:57:03 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1304.414569 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 44 secs) (at 2015-11-05 05:57:03.793182) ========= ========= Started set props: build_url (results: 0, elapsed: 2 secs) (at 2015-11-05 05:57:03.797867) ========= 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.GNVMHtXvPt/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.2m2FLfLJYQ/Listeners TMPDIR=/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/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:0x0:0x0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/4HLF7bZtSW-wpSI8QhQYsg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009809 build_url: 'https://queue.taskcluster.net/v1/task/4HLF7bZtSW-wpSI8QhQYsg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 2.22 ========= ========= Finished set props: build_url (results: 0, elapsed: 2 secs) (at 2015-11-05 05:57:06.023688) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 05:57:06.024060) ========= 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.GNVMHtXvPt/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.2m2FLfLJYQ/Listeners TMPDIR=/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/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:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005195 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 05:57:06.054236) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-05 05:57:06.054625) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-05 05:57:06.055720) ========= ========= Total master_lag: 2.58 =========