builder: fx-team_yosemite_test-dromaeojs-e10s slave: t-yosemite-r5-0083 starttime: 1446719276.63 results: success (0) buildid: 20151105005737 builduid: f16c1336cd1a4742bb6ecc41afbc2763 revision: c951580b6f9b81f7dcab62b40d03ad96d666e1ca ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-05 02:27:56.626057) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-05 02:27:56.626568) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-05 02:27:56.626900) ========= 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.cW8ohHWoYx/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.U9WpRmfQiY/Listeners TMPDIR=/var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/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.006731 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-05 02:27:56.692678) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-05 02:27:56.693054) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-05 02:27:56.722916) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 02:27:56.723433) ========= 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.cW8ohHWoYx/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.U9WpRmfQiY/Listeners TMPDIR=/var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/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.014770 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 02:27:56.774002) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-05 02:27:56.774382) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-05 02:27:56.774804) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 02:27:56.775114) ========= 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.cW8ohHWoYx/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.U9WpRmfQiY/Listeners TMPDIR=/var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/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 02:27:56-- 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 02:27:56 (1.41 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.135084 ========= master_lag: 0.14 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 02:27:57.048122) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 02:27:57.051505) ========= 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.cW8ohHWoYx/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.U9WpRmfQiY/Listeners TMPDIR=/var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/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.073755 ========= master_lag: 0.13 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 02:27:57.258959) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 02:27:57.259348) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c951580b6f9b81f7dcab62b40d03ad96d666e1ca --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 c951580b6f9b81f7dcab62b40d03ad96d666e1ca --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cW8ohHWoYx/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.U9WpRmfQiY/Listeners TMPDIR=/var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/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 02:27:57,352 truncating revision to first 12 chars 2015-11-05 02:27:57,352 Setting DEBUG logging. 2015-11-05 02:27:57,352 attempt 1/10 2015-11-05 02:27:57,353 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c951580b6f9b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-05 02:27:57,636 unpacking tar archive at: fx-team-c951580b6f9b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.725933 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 02:27:58.007325) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-05 02:27:58.007726) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-05 02:27:58.025375) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-05 02:27:58.025836) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-05 02:27:58.026337) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 24 secs) (at 2015-11-05 02:27:58.026724) ========= /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.cW8ohHWoYx/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.U9WpRmfQiY/Listeners TMPDIR=/var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/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 02:27:58 INFO - MultiFileLogger online at 20151105 02:27:58 in /builds/slave/test 02:27:58 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 02:27:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:27:58 INFO - {'append_to_log': False, 02:27:58 INFO - 'base_work_dir': '/builds/slave/test', 02:27:58 INFO - 'blob_upload_branch': 'Fx-Team', 02:27:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:27:58 INFO - 'branch': 'Fx-Team', 02:27:58 INFO - 'buildbot_json_path': 'buildprops.json', 02:27:58 INFO - 'config_files': ('talos/mac_config.py',), 02:27:58 INFO - 'default_actions': ('clobber', 02:27:58 INFO - 'read-buildbot-config', 02:27:58 INFO - 'download-and-extract', 02:27:58 INFO - 'populate-webroot', 02:27:58 INFO - 'create-virtualenv', 02:27:58 INFO - 'install', 02:27:58 INFO - 'run-tests'), 02:27:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:27:58 INFO - 'download_minidump_stackwalk': True, 02:27:58 INFO - 'download_symbols': 'ondemand', 02:27:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:27:58 INFO - 'tooltool.py': '/tools/tooltool.py', 02:27:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:27:58 INFO - '/tools/misc-python/virtualenv.py')}, 02:27:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:27:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:27:58 INFO - 'installer_path': 'installer.exe', 02:27:58 INFO - 'log_level': 'info', 02:27:58 INFO - 'log_name': 'talos', 02:27:58 INFO - 'log_to_console': True, 02:27:58 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:27:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:27:58 INFO - 'opt_config_files': (), 02:27:58 INFO - 'pip_index': False, 02:27:58 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:27:58 INFO - 'cmd': ('bash', 02:27:58 INFO - '-c', 02:27:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:27:58 INFO - 'enabled': True, 02:27:58 INFO - 'halt_on_failure': False, 02:27:58 INFO - 'name': 'check_screen_resolution'},), 02:27:58 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:27:58 INFO - 'cmd': ('bash', 02:27:58 INFO - '-c', 02:27:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:27:58 INFO - 'enabled': True, 02:27:58 INFO - 'halt_on_failure': False, 02:27:58 INFO - 'name': 'check_screen_resolution'},), 02:27:58 INFO - 'run_cmd_checks_enabled': True, 02:27:58 INFO - 'sps_profile': False, 02:27:58 INFO - 'sps_profile_interval': 0, 02:27:58 INFO - 'suite': 'dromaeojs-e10s', 02:27:58 INFO - 'system_bits': '64', 02:27:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:27:58 INFO - 'title': 't-yosemite-r5-0083', 02:27:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:27:58 INFO - 'use_talos_json': True, 02:27:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:27:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:27:58 INFO - 'work_dir': 'build'} 02:27:58 INFO - ##### 02:27:58 INFO - ##### Running clobber step. 02:27:58 INFO - ##### 02:27:58 INFO - Running pre-action listener: _resource_record_pre_action 02:27:58 INFO - Running main action method: clobber 02:27:58 INFO - rmtree: /builds/slave/test/build 02:27:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:28:04 INFO - Running post-action listener: _resource_record_post_action 02:28:04 INFO - ##### 02:28:04 INFO - ##### Running read-buildbot-config step. 02:28:04 INFO - ##### 02:28:04 INFO - Running pre-action listener: _resource_record_pre_action 02:28:04 INFO - Running main action method: read_buildbot_config 02:28:04 INFO - Using buildbot properties: 02:28:04 INFO - { 02:28:04 INFO - "properties": { 02:28:04 INFO - "buildnumber": 10, 02:28:04 INFO - "product": "firefox", 02:28:04 INFO - "script_repo_revision": "production", 02:28:04 INFO - "builddir": "fx-team_yosemite_test-dromaeojs-e10s", 02:28:04 INFO - "repository": "", 02:28:04 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 fx-team talos dromaeojs-e10s", 02:28:04 INFO - "buildid": "20151105005737", 02:28:04 INFO - "slavename": "t-yosemite-r5-0083", 02:28:04 INFO - "pgo_build": "False", 02:28:04 INFO - "basedir": "/builds/slave/test", 02:28:04 INFO - "project": "", 02:28:04 INFO - "platform": "yosemite", 02:28:04 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 02:28:04 INFO - "slavebuilddir": "test", 02:28:04 INFO - "scheduler": "tests-fx-team-macosx64-talos", 02:28:04 INFO - "branch": "fx-team", 02:28:04 INFO - "repo_path": "integration/fx-team", 02:28:04 INFO - "stage_platform": "macosx64", 02:28:04 INFO - "builduid": "f16c1336cd1a4742bb6ecc41afbc2763", 02:28:04 INFO - "revision": "c951580b6f9b81f7dcab62b40d03ad96d666e1ca" 02:28:04 INFO - }, 02:28:04 INFO - "sourcestamp": { 02:28:04 INFO - "repository": "", 02:28:04 INFO - "hasPatch": false, 02:28:04 INFO - "project": "", 02:28:04 INFO - "branch": "fx-team-macosx64-talos", 02:28:04 INFO - "changes": [ 02:28:04 INFO - { 02:28:04 INFO - "category": null, 02:28:04 INFO - "files": [ 02:28:04 INFO - { 02:28:04 INFO - "url": null, 02:28:04 INFO - "name": "https://queue.taskcluster.net/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 02:28:04 INFO - } 02:28:04 INFO - ], 02:28:04 INFO - "repository": "", 02:28:04 INFO - "rev": "c951580b6f9b81f7dcab62b40d03ad96d666e1ca", 02:28:04 INFO - "who": "cbook@mozilla.com", 02:28:04 INFO - "when": 1446717528, 02:28:04 INFO - "number": 6624111, 02:28:04 INFO - "comments": "Bug 1215147 - Enable VR API's on FF for Android by default. r=snorp, r=vlad, r=bz", 02:28:04 INFO - "project": "", 02:28:04 INFO - "at": "Thu 05 Nov 2015 01:58:48", 02:28:04 INFO - "branch": "fx-team-macosx64-talos", 02:28:04 INFO - "revlink": "", 02:28:04 INFO - "properties": [ 02:28:04 INFO - [ 02:28:04 INFO - "buildid", 02:28:04 INFO - "20151105005737", 02:28:04 INFO - "Change" 02:28:04 INFO - ], 02:28:04 INFO - [ 02:28:04 INFO - "builduid", 02:28:04 INFO - "f16c1336cd1a4742bb6ecc41afbc2763", 02:28:04 INFO - "Change" 02:28:04 INFO - ], 02:28:04 INFO - [ 02:28:04 INFO - "pgo_build", 02:28:04 INFO - "False", 02:28:04 INFO - "Change" 02:28:04 INFO - ] 02:28:04 INFO - ], 02:28:04 INFO - "revision": "c951580b6f9b81f7dcab62b40d03ad96d666e1ca" 02:28:04 INFO - } 02:28:04 INFO - ], 02:28:04 INFO - "revision": "c951580b6f9b81f7dcab62b40d03ad96d666e1ca" 02:28:04 INFO - } 02:28:04 INFO - } 02:28:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 02:28:04 INFO - Running post-action listener: _resource_record_post_action 02:28:04 INFO - ##### 02:28:04 INFO - ##### Running download-and-extract step. 02:28:04 INFO - ##### 02:28:04 INFO - Running pre-action listener: _resource_record_pre_action 02:28:04 INFO - Running main action method: download_and_extract 02:28:04 INFO - mkdir: /builds/slave/test/build/tests 02:28:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:04 INFO - https://queue.taskcluster.net/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:28:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/test_packages.json 02:28:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/test_packages.json 02:28:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 02:28:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 02:28:04 INFO - Downloaded 1149 bytes. 02:28:04 INFO - Reading from file /builds/slave/test/build/test_packages.json 02:28:04 INFO - Using the following test package requirements: 02:28:04 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 02:28:04 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 02:28:04 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 02:28:04 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 02:28:04 INFO - u'jsshell-mac.zip'], 02:28:04 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 02:28:04 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 02:28:04 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 02:28:04 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 02:28:04 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 02:28:04 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 02:28:04 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 02:28:04 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 02:28:04 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 02:28:04 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 02:28:04 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 02:28:04 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 02:28:04 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 02:28:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:04 INFO - https://queue.taskcluster.net/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:28:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 02:28:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 02:28:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/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 02:28:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/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 02:28:05 INFO - Downloaded 17457225 bytes. 02:28:05 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 02:28:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 02:28:05 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 02:28:16 INFO - Return code: 0 02:28:16 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 02:28:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:16 INFO - https://queue.taskcluster.net/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:28:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 02:28:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 02:28:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/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 02:28:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/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 02:28:18 INFO - Downloaded 17457225 bytes. 02:28:18 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 02:28:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 02:28:18 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 02:28:28 INFO - Return code: 0 02:28:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:28 INFO - https://queue.taskcluster.net/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:28:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 02:28:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 02:28:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/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 02:28:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/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 02:28:29 INFO - Downloaded 11131307 bytes. 02:28:29 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 02:28:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 02:28:29 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 02:28:31 INFO - Return code: 0 02:28: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')]} 02:28:31 INFO - https://queue.taskcluster.net/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 02:28:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 02:28:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 02:28:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 02:28:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/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 02:28:37 INFO - Downloaded 108647076 bytes. 02:28:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 02:28:37 INFO - mkdir: /builds/slave/test/properties 02:28:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:28:37 INFO - Writing to file /builds/slave/test/properties/build_url 02:28:37 INFO - Contents: 02:28:37 INFO - build_url:https://queue.taskcluster.net/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 02:28:37 INFO - Running post-action listener: _resource_record_post_action 02:28:37 INFO - Running post-action listener: set_extra_try_arguments 02:28:37 INFO - ##### 02:28:37 INFO - ##### Running populate-webroot step. 02:28:37 INFO - ##### 02:28:37 INFO - Running pre-action listener: _resource_record_pre_action 02:28:37 INFO - Running main action method: populate_webroot 02:28:37 INFO - Guessing talos json url... 02:28: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')]} 02:28:37 INFO - https://queue.taskcluster.net/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.txt matches https://queue.taskcluster.net 02:28:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 02:28:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 02:28:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.txt to /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 02:28:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/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 02:28:37 INFO - Downloaded 103 bytes. 02:28:37 INFO - Reading from file /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 02:28:37 INFO - Contents: 02:28:37 INFO - 20151105005737 02:28:37 INFO - https://hg.mozilla.org/integration/fx-team/rev/c951580b6f9b81f7dcab62b40d03ad96d666e1ca 02:28: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')]} 02:28:37 INFO - trying https://hg.mozilla.org/integration/fx-team/raw-file/c951580b6f/testing/talos/talos.json 02:28:37 INFO - Downloading https://hg.mozilla.org/integration/fx-team/raw-file/c951580b6f/testing/talos/talos.json to /builds/slave/test/build/talos.json 02:28:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/integration/fx-team/raw-file/c951580b6f/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 02:28:38 INFO - Downloaded 4264 bytes. 02:28:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:28:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:28:38 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 02:28:38 INFO - '../fennec_ids.txt'], 02:28:38 INFO - 'tests': ['tcheck2']}, 02:28:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:28:38 INFO - '--tppagecycles', 02:28:38 INFO - '7'], 02:28:38 INFO - 'tests': ['tsvgm']}}, 02:28:38 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:28:38 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:28:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:28:38 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:28:38 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:28:38 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:28:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:28:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:38 INFO - 'talos_options': ['--e10s'], 02:28:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:28:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:38 INFO - 'tests': ['damp', 'tps']}, 02:28:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:38 INFO - 'talos_options': ['--e10s'], 02:28:38 INFO - 'tests': ['damp', 'tps']}, 02:28:38 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:28:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:28:38 INFO - 'other': {'tests': ['a11yr', 02:28:38 INFO - 'ts_paint', 02:28:38 INFO - 'tpaint', 02:28:38 INFO - 'sessionrestore', 02:28:38 INFO - 'sessionrestore_no_auto_restore']}, 02:28:38 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:28:38 INFO - 'tests': ['a11yr', 02:28:38 INFO - 'ts_paint', 02:28:38 INFO - 'tpaint', 02:28:38 INFO - 'sessionrestore', 02:28:38 INFO - 'sessionrestore_no_auto_restore']}, 02:28:38 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:28:38 INFO - 'tests': ['a11yr', 02:28:38 INFO - 'ts_paint', 02:28:38 INFO - 'tpaint', 02:28:38 INFO - 'sessionrestore', 02:28:38 INFO - 'sessionrestore_no_auto_restore']}, 02:28:38 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:28:38 INFO - 'tests': ['a11yr', 02:28:38 INFO - 'ts_paint', 02:28:38 INFO - 'tpaint', 02:28:38 INFO - 'sessionrestore', 02:28:38 INFO - 'sessionrestore_no_auto_restore']}, 02:28:38 INFO - 'other_l64': {'tests': ['a11yr', 02:28:38 INFO - 'ts_paint', 02:28:38 INFO - 'tpaint', 02:28:38 INFO - 'sessionrestore', 02:28:38 INFO - 'sessionrestore_no_auto_restore']}, 02:28:38 INFO - 'other_nol64': {'tests': ['a11yr', 02:28:38 INFO - 'ts_paint', 02:28:38 INFO - 'tpaint', 02:28:38 INFO - 'sessionrestore', 02:28:38 INFO - 'sessionrestore_no_auto_restore']}, 02:28:38 INFO - 'svgr': {'tests': ['tsvgx', 02:28:38 INFO - 'tsvgr_opacity', 02:28:38 INFO - 'tart', 02:28:38 INFO - 'tscrollx', 02:28:38 INFO - 'cart']}, 02:28:38 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:28:38 INFO - 'tests': ['tsvgx', 02:28:38 INFO - 'tsvgr_opacity', 02:28:38 INFO - 'tart', 02:28:38 INFO - 'tscrollx', 02:28:38 INFO - 'cart']}, 02:28:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:38 INFO - 'tests': ['tp5o']}, 02:28:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:38 INFO - 'talos_options': ['--e10s'], 02:28:38 INFO - 'tests': ['tp5o']}, 02:28:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:38 INFO - 'talos_options': ['--xperf_path', 02:28:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:28:38 INFO - 'tests': ['tp5n']}, 02:28:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:38 INFO - 'talos_options': ['--e10s', 02:28:38 INFO - '--xperf_path', 02:28:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 02:28:38 INFO - 'C:/slave/talos-data/talos/xperf.config'], 02:28:38 INFO - 'tests': ['tp5n']}}, 02:28:38 INFO - 'talos.zip': {'path': '', 02:28:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:28:38 INFO - Running post-action listener: _resource_record_post_action 02:28:38 INFO - ##### 02:28:38 INFO - ##### Running create-virtualenv step. 02:28:38 INFO - ##### 02:28:38 INFO - Running pre-action listener: _resource_record_pre_action 02:28:38 INFO - Running main action method: create_virtualenv 02:28:38 INFO - Creating virtualenv /builds/slave/test/build/venv 02:28:38 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 02:28:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:28:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:28:38 INFO - Using real prefix '/tools/python27' 02:28:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:28:39 INFO - Installing distribute.............................................................................................................................................................................................done. 02:28:43 INFO - Installing pip.................done. 02:28:43 INFO - Return code: 0 02:28:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:28:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:43 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 0x10b7bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b82c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c1ae01dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7749f0>, '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 0x10b4d3cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b73e990>, '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.cW8ohHWoYx/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.U9WpRmfQiY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/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 02:28:43 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 02:28:43 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 02:28:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cW8ohHWoYx/Render', 02:28:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:28:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:28:43 INFO - 'HOME': '/Users/cltbld', 02:28:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:28:43 INFO - 'LOGNAME': 'cltbld', 02:28:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:43 INFO - 'MOZ_NO_REMOTE': '1', 02:28:43 INFO - 'NO_EM_RESTART': '1', 02:28:43 INFO - 'PAGER': '/bin/cat', 02:28:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:28:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:43 INFO - 'PWD': '/builds/slave/test', 02:28:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:28:43 INFO - 'SHELL': '/bin/bash', 02:28:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U9WpRmfQiY/Listeners', 02:28:43 INFO - 'TMPDIR': '/var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/T/', 02:28:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:28:43 INFO - 'USER': 'cltbld', 02:28:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:28:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:28:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:43 INFO - 'XPC_FLAGS': '0x0', 02:28:43 INFO - 'XPC_SERVICE_NAME': '0', 02:28:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:28:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:44 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 02:28:44 INFO - Cleaning up... 02:28:44 INFO - Return code: 0 02:28:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:28:44 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')]} 02:28:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:44 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')]} 02:28:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:44 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 0x10b7bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b82c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c1ae01dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7749f0>, '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 0x10b4d3cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b73e990>, '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.cW8ohHWoYx/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.U9WpRmfQiY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/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 02:28:44 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 02:28:44 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 02:28:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cW8ohHWoYx/Render', 02:28:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:28:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:28:44 INFO - 'HOME': '/Users/cltbld', 02:28:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:28:44 INFO - 'LOGNAME': 'cltbld', 02:28:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:44 INFO - 'MOZ_NO_REMOTE': '1', 02:28:44 INFO - 'NO_EM_RESTART': '1', 02:28:44 INFO - 'PAGER': '/bin/cat', 02:28:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:28:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:44 INFO - 'PWD': '/builds/slave/test', 02:28:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:28:44 INFO - 'SHELL': '/bin/bash', 02:28:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U9WpRmfQiY/Listeners', 02:28:44 INFO - 'TMPDIR': '/var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/T/', 02:28:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:28:44 INFO - 'USER': 'cltbld', 02:28:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:28:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:28:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:44 INFO - 'XPC_FLAGS': '0x0', 02:28:44 INFO - 'XPC_SERVICE_NAME': '0', 02:28:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:28:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:45 INFO - Downloading/unpacking psutil>=0.7.1 02:28:45 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 02:28:45 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 02:28:45 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 02:28:45 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 02:28:45 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 02:28:45 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 02:28:47 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 02:28:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 02:28:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:28:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:28:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:28:48 INFO - Installing collected packages: psutil 02:28:48 INFO - Running setup.py install for psutil 02:28:48 INFO - building 'psutil._psutil_osx' extension 02:28:48 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 02:28: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_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 02:28: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/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 02:28:51 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 02:28:51 INFO - building 'psutil._psutil_posix' extension 02:28:51 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 02:28:52 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:28:52 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:28:52 INFO - ^ 02:28:52 INFO - 1 warning generated. 02:28:52 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 02:28:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:28:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:28:52 INFO - Successfully installed psutil 02:28:52 INFO - Cleaning up... 02:28:52 INFO - Return code: 0 02:28:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:28:52 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')]} 02:28:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:52 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')]} 02:28:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:52 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 0x10b7bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b82c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c1ae01dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7749f0>, '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 0x10b4d3cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b73e990>, '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.cW8ohHWoYx/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.U9WpRmfQiY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/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 02:28:52 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 02:28:52 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 02:28:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cW8ohHWoYx/Render', 02:28:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:28:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:28:52 INFO - 'HOME': '/Users/cltbld', 02:28:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:28:52 INFO - 'LOGNAME': 'cltbld', 02:28:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:52 INFO - 'MOZ_NO_REMOTE': '1', 02:28:52 INFO - 'NO_EM_RESTART': '1', 02:28:52 INFO - 'PAGER': '/bin/cat', 02:28:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:28:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:52 INFO - 'PWD': '/builds/slave/test', 02:28:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:28:52 INFO - 'SHELL': '/bin/bash', 02:28:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U9WpRmfQiY/Listeners', 02:28:52 INFO - 'TMPDIR': '/var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/T/', 02:28:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:28:52 INFO - 'USER': 'cltbld', 02:28:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:28:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:28:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:52 INFO - 'XPC_FLAGS': '0x0', 02:28:52 INFO - 'XPC_SERVICE_NAME': '0', 02:28:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:28:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:28:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:28:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:28:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:28:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:28:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:28:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:28:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:28:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 02:28:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:28:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:28:55 INFO - Installing collected packages: mozsystemmonitor 02:28:55 INFO - Running setup.py install for mozsystemmonitor 02:28:55 INFO - Successfully installed mozsystemmonitor 02:28:55 INFO - Cleaning up... 02:28:55 INFO - Return code: 0 02:28:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:28:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:55 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 0x10b7bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b82c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c1ae01dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7749f0>, '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 0x10b4d3cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b73e990>, '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.cW8ohHWoYx/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.U9WpRmfQiY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/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 02:28:55 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 02:28:55 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 02:28:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cW8ohHWoYx/Render', 02:28:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:28:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:28:55 INFO - 'HOME': '/Users/cltbld', 02:28:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:28:55 INFO - 'LOGNAME': 'cltbld', 02:28:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:55 INFO - 'MOZ_NO_REMOTE': '1', 02:28:55 INFO - 'NO_EM_RESTART': '1', 02:28:55 INFO - 'PAGER': '/bin/cat', 02:28:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:28:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:55 INFO - 'PWD': '/builds/slave/test', 02:28:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:28:55 INFO - 'SHELL': '/bin/bash', 02:28:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U9WpRmfQiY/Listeners', 02:28:55 INFO - 'TMPDIR': '/var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/T/', 02:28:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:28:55 INFO - 'USER': 'cltbld', 02:28:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:28:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:28:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:55 INFO - 'XPC_FLAGS': '0x0', 02:28:55 INFO - 'XPC_SERVICE_NAME': '0', 02:28:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:28:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:56 INFO - Downloading/unpacking blobuploader==1.2.4 02:28:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:28:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:28:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:28:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:28:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:28:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:28:59 INFO - Downloading blobuploader-1.2.4.tar.gz 02:28:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 02:28:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:28:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:28:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:28:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:28:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:28:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:28:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:28:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:28:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 02:28:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:29:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:29: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 02:29: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 02:29: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 02:29: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 02:29: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 02:29: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 02:29:00 INFO - Downloading docopt-0.6.1.tar.gz 02:29:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 02:29:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:29:00 INFO - Installing collected packages: blobuploader, requests, docopt 02:29:00 INFO - Running setup.py install for blobuploader 02:29:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:29:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:29:00 INFO - Running setup.py install for requests 02:29:01 INFO - Running setup.py install for docopt 02:29:01 INFO - Successfully installed blobuploader requests docopt 02:29:01 INFO - Cleaning up... 02:29:01 INFO - Return code: 0 02:29:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:29:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:01 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 0x10b7bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b82c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c1ae01dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7749f0>, '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 0x10b4d3cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b73e990>, '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.cW8ohHWoYx/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.U9WpRmfQiY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/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 02:29:01 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 02:29:01 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 02:29:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cW8ohHWoYx/Render', 02:29:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:29:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:29:01 INFO - 'HOME': '/Users/cltbld', 02:29:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:29:01 INFO - 'LOGNAME': 'cltbld', 02:29:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:01 INFO - 'MOZ_NO_REMOTE': '1', 02:29:01 INFO - 'NO_EM_RESTART': '1', 02:29:01 INFO - 'PAGER': '/bin/cat', 02:29:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:29:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:01 INFO - 'PWD': '/builds/slave/test', 02:29:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:29:01 INFO - 'SHELL': '/bin/bash', 02:29:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U9WpRmfQiY/Listeners', 02:29:01 INFO - 'TMPDIR': '/var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/T/', 02:29:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:29:01 INFO - 'USER': 'cltbld', 02:29:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:29:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:29:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:01 INFO - 'XPC_FLAGS': '0x0', 02:29:01 INFO - 'XPC_SERVICE_NAME': '0', 02:29:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:29:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:29:02 INFO - Running setup.py (path:/var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/T/pip-nRIw4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:29:02 INFO - Running setup.py (path:/var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/T/pip-LmyP5m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:29:02 INFO - Running setup.py (path:/var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/T/pip-k4G2Tq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:29:02 INFO - Running setup.py (path:/var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/T/pip-qwMeFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:29:02 INFO - Running setup.py (path:/var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/T/pip-L8vwMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:29:02 INFO - Running setup.py (path:/var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/T/pip-QupPQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:29:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:29:03 INFO - Running setup.py (path:/var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/T/pip-7VIwQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:29:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:29:03 INFO - Running setup.py (path:/var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/T/pip-aAM4qT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:29:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:29:03 INFO - Running setup.py (path:/var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/T/pip-MxcdEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:29:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:29:03 INFO - Running setup.py (path:/var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/T/pip-DOSHDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:29:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:29:03 INFO - Running setup.py (path:/var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/T/pip-MENeKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:29:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:29:03 INFO - Running setup.py (path:/var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/T/pip-cGR4EW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:29:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:29:03 INFO - Running setup.py (path:/var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/T/pip-0nxJCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:29:04 INFO - Running setup.py (path:/var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/T/pip-Pnnf5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:29:04 INFO - Running setup.py (path:/var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/T/pip-oBWCQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:29:04 INFO - Running setup.py (path:/var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/T/pip-Xw4ZOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:29:04 INFO - Running setup.py (path:/var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/T/pip-38D8QQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:29:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:29:04 INFO - Running setup.py install for manifestparser 02:29:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:29:04 INFO - Running setup.py install for mozcrash 02:29:05 INFO - Running setup.py install for mozdebug 02:29:05 INFO - Running setup.py install for mozdevice 02:29:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:29:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:29:05 INFO - Running setup.py install for mozfile 02:29:05 INFO - Running setup.py install for mozhttpd 02:29:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:29:05 INFO - Running setup.py install for mozinfo 02:29:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:29:06 INFO - Running setup.py install for mozInstall 02:29:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:29:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:29:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:29:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:29:06 INFO - Running setup.py install for mozleak 02:29:06 INFO - Running setup.py install for mozlog 02:29:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:29:06 INFO - Running setup.py install for moznetwork 02:29:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:29:06 INFO - Running setup.py install for mozprocess 02:29:07 INFO - Running setup.py install for mozprofile 02:29:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:29:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:29:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:29:07 INFO - Running setup.py install for mozrunner 02:29:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:29:07 INFO - Running setup.py install for mozscreenshot 02:29:07 INFO - Running setup.py install for moztest 02:29:07 INFO - Running setup.py install for mozversion 02:29:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:29:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:29:08 INFO - Cleaning up... 02:29:08 INFO - Return code: 0 02:29:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:29: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')]} 02:29:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29: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')]} 02:29:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29: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 0x10b7bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b82c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c1ae01dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7749f0>, '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 0x10b4d3cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b73e990>, '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.cW8ohHWoYx/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.U9WpRmfQiY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/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 02:29: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 02:29: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 02:29:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cW8ohHWoYx/Render', 02:29:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:29:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:29:08 INFO - 'HOME': '/Users/cltbld', 02:29:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:29:08 INFO - 'LOGNAME': 'cltbld', 02:29:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:08 INFO - 'MOZ_NO_REMOTE': '1', 02:29:08 INFO - 'NO_EM_RESTART': '1', 02:29:08 INFO - 'PAGER': '/bin/cat', 02:29:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:29:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:08 INFO - 'PWD': '/builds/slave/test', 02:29:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:29:08 INFO - 'SHELL': '/bin/bash', 02:29:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U9WpRmfQiY/Listeners', 02:29:08 INFO - 'TMPDIR': '/var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/T/', 02:29:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:29:08 INFO - 'USER': 'cltbld', 02:29:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:29:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:29:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:08 INFO - 'XPC_FLAGS': '0x0', 02:29:08 INFO - 'XPC_SERVICE_NAME': '0', 02:29:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:29:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:29:08 INFO - Running setup.py (path:/var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/T/pip-sN0ZdP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:29: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)) 02:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:29:08 INFO - Running setup.py (path:/var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/T/pip-2OHK8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:29: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)) 02:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:29:08 INFO - Running setup.py (path:/var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/T/pip-T1bpFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:29: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)) 02:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:29:08 INFO - Running setup.py (path:/var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/T/pip-GEvrEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:29:09 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)) 02:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:29:09 INFO - Running setup.py (path:/var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/T/pip-lzUT5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:29: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)) 02:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:29:09 INFO - Running setup.py (path:/var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/T/pip-9LST7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:29: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)) 02:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:29:09 INFO - Running setup.py (path:/var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/T/pip-VhIE6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:29: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)) 02:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:29:09 INFO - Running setup.py (path:/var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/T/pip-8S6vTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:29: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)) 02:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:29:09 INFO - Running setup.py (path:/var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/T/pip-FTMX01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:29: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)) 02:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:29:09 INFO - Running setup.py (path:/var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/T/pip-bcRwHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:29:10 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)) 02:29:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:29:10 INFO - Running setup.py (path:/var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/T/pip-C4Gj85-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:29:10 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)) 02:29:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:29:10 INFO - Running setup.py (path:/var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/T/pip-FY6m5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:29:10 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)) 02:29:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:29:10 INFO - Running setup.py (path:/var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/T/pip-k_IQgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:29: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)) 02:29:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:29:10 INFO - Running setup.py (path:/var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/T/pip-9lGx3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:29: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)) 02:29:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:29:10 INFO - Running setup.py (path:/var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/T/pip-KHDxmD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:29: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)) 02:29:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:29:10 INFO - Running setup.py (path:/var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/T/pip-J0t2z6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:29: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)) 02:29:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:29:10 INFO - Running setup.py (path:/var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/T/pip-LKusZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:29:11 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)) 02:29:11 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)) 02:29:11 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)) 02:29:11 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)) 02:29:11 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)) 02:29:11 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)) 02:29:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:29:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:13 INFO - Downloading blessings-1.5.1.tar.gz 02:29:13 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 02:29:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:29:14 INFO - Installing collected packages: blessings 02:29:14 INFO - Running setup.py install for blessings 02:29:14 INFO - Successfully installed blessings 02:29:14 INFO - Cleaning up... 02:29:14 INFO - Return code: 0 02:29:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:29:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:29:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:29:14 INFO - Reading from file tmpfile_stdout 02:29:14 INFO - Current package versions: 02:29:14 INFO - blessings == 1.5.1 02:29:14 INFO - blobuploader == 1.2.4 02:29:14 INFO - docopt == 0.6.1 02:29:14 INFO - manifestparser == 1.1 02:29:14 INFO - mozInstall == 1.12 02:29:14 INFO - mozcrash == 0.16 02:29:14 INFO - mozdebug == 0.1 02:29:14 INFO - mozdevice == 0.47 02:29:14 INFO - mozfile == 1.2 02:29:14 INFO - mozhttpd == 0.7 02:29:14 INFO - mozinfo == 0.9 02:29:14 INFO - mozleak == 0.1 02:29:14 INFO - mozlog == 3.0 02:29:14 INFO - moznetwork == 0.27 02:29:14 INFO - mozprocess == 0.22 02:29:14 INFO - mozprofile == 0.27 02:29:14 INFO - mozrunner == 6.11 02:29:14 INFO - mozscreenshot == 0.1 02:29:14 INFO - mozsystemmonitor == 0.0 02:29:14 INFO - moztest == 0.7 02:29:14 INFO - mozversion == 1.4 02:29:14 INFO - psutil == 3.1.1 02:29:14 INFO - requests == 1.2.3 02:29:14 INFO - wsgiref == 0.1.2 02:29:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:29:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:14 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 0x10b7bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b82c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c1ae01dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7749f0>, '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 0x10b4d3cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b73e990>, '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.cW8ohHWoYx/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.U9WpRmfQiY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/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 02:29:14 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 02:29:14 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 02:29:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cW8ohHWoYx/Render', 02:29:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:29:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:29:14 INFO - 'HOME': '/Users/cltbld', 02:29:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:29:14 INFO - 'LOGNAME': 'cltbld', 02:29:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:14 INFO - 'MOZ_NO_REMOTE': '1', 02:29:14 INFO - 'NO_EM_RESTART': '1', 02:29:14 INFO - 'PAGER': '/bin/cat', 02:29:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:29:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:14 INFO - 'PWD': '/builds/slave/test', 02:29:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:29:14 INFO - 'SHELL': '/bin/bash', 02:29:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U9WpRmfQiY/Listeners', 02:29:14 INFO - 'TMPDIR': '/var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/T/', 02:29:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:29:14 INFO - 'USER': 'cltbld', 02:29:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:29:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:29:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:14 INFO - 'XPC_FLAGS': '0x0', 02:29:14 INFO - 'XPC_SERVICE_NAME': '0', 02:29:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:29:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:15 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)) 02:29:15 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)) 02:29:15 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)) 02:29:15 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)) 02:29:15 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)) 02:29:15 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)) 02:29:15 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)) 02:29:15 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)) 02:29:15 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)) 02:29:15 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)) 02:29:15 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)) 02:29:15 INFO - Cleaning up... 02:29:15 INFO - Return code: 0 02:29:15 INFO - Running post-action listener: _resource_record_post_action 02:29:15 INFO - Running post-action listener: _start_resource_monitoring 02:29:15 INFO - Starting resource monitoring. 02:29:15 INFO - ##### 02:29:15 INFO - ##### Running install step. 02:29:15 INFO - ##### 02:29:15 INFO - Running pre-action listener: _resource_record_pre_action 02:29:15 INFO - Running main action method: install 02:29:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:29:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:29:15 INFO - Reading from file tmpfile_stdout 02:29:15 INFO - Detecting whether we're running mozinstall >=1.0... 02:29:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:29:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:29:15 INFO - Reading from file tmpfile_stdout 02:29:15 INFO - Output received: 02:29:15 INFO - Usage: mozinstall [options] installer 02:29:15 INFO - Options: 02:29:15 INFO - -h, --help show this help message and exit 02:29:15 INFO - -d DEST, --destination=DEST 02:29:15 INFO - Directory to install application into. [default: 02:29:15 INFO - "/builds/slave/test"] 02:29:15 INFO - --app=APP Application being installed. [default: firefox] 02:29:15 INFO - mkdir: /builds/slave/test/build/application 02:29:15 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'] 02:29:15 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 02:30:00 INFO - Reading from file tmpfile_stdout 02:30:00 INFO - Output received: 02:30:00 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 02:30:00 INFO - Running post-action listener: _resource_record_post_action 02:30:00 INFO - ##### 02:30:00 INFO - ##### Running run-tests step. 02:30:00 INFO - ##### 02:30:00 INFO - Running pre-action listener: _resource_record_pre_action 02:30:00 INFO - Running main action method: run_tests 02:30:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:30:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:30:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:30:00 INFO - 2015-11-05 02:30:00.243 screenresolution[1627:7499] starting screenresolution argv=screenresolution get 02:30:00 INFO - 2015-11-05 02:30:00.247 screenresolution[1627:7499] Display 0: 1600x1200x32@60 02:30:00 INFO - 2015-11-05 02:30:00.254 screenresolution[1628:7501] starting screenresolution argv=screenresolution list 02:30:00 INFO - Available Modes on Display 0 02:30:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:30:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:30:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:30:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:30:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:30:00 INFO - Intel HD Graphics 3000: 02:30:00 INFO - Chipset Model: Intel HD Graphics 3000 02:30:00 INFO - Type: GPU 02:30:00 INFO - Bus: Built-In 02:30:00 INFO - VRAM (Total): 512 MB 02:30:00 INFO - VRAM (Dynamic, Max): 10 02:30:00 INFO - Vendor: Intel (0x8086) 02:30:00 INFO - Device ID: 0x0116 02:30:00 INFO - Revision ID: 0x0009 02:30:00 INFO - Displays: 02:30:00 INFO - Display: 02:30:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:30:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:30:00 INFO - Display Serial Number: 1600x1200 60 02:30:00 INFO - Main Display: Yes 02:30:00 INFO - Mirror: Off 02:30:00 INFO - Online: Yes 02:30:00 INFO - Rotation: Supported 02:30:00 INFO - Return code: 0 02:30:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:30:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:30:00 INFO - Python 2.7.3 02:30:00 INFO - Return code: 0 02:30:00 INFO - grabbing minidump binary from tooltool 02:30:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:30:00 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 0x10b7749f0>, '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 0x10b4d3cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b73e990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:30:00 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 02:30:00 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 02:30:00 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:30:00 INFO - Return code: 0 02:30:00 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:30:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:30:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:30:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:30:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:30:00 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/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0083', '--webServer', 'localhost'] in /builds/slave/test/build 02:30:00 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/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0083 --webServer localhost 02:30:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cW8ohHWoYx/Render', 02:30:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:30:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:30:00 INFO - 'HOME': '/Users/cltbld', 02:30:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:30:00 INFO - 'LOGNAME': 'cltbld', 02:30:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:30:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:30:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:00 INFO - 'MOZ_NO_REMOTE': '1', 02:30:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:30:00 INFO - 'NO_EM_RESTART': '1', 02:30:00 INFO - 'PAGER': '/bin/cat', 02:30:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:30:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:00 INFO - 'PWD': '/builds/slave/test', 02:30:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:30:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:30:00 INFO - 'SHELL': '/bin/bash', 02:30:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U9WpRmfQiY/Listeners', 02:30:00 INFO - 'TMPDIR': '/var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/T/', 02:30:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:30:00 INFO - 'USER': 'cltbld', 02:30:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:30:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:30:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:00 INFO - 'XPC_FLAGS': '0x0', 02:30:00 INFO - 'XPC_SERVICE_NAME': '0', 02:30:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:30:00 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/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0083', '--webServer', 'localhost'] with output_timeout 3600 02:30:01 INFO - mozversion INFO | application_buildid: 20151105005737 02:30:01 INFO - mozversion INFO | application_changeset: c951580b6f9b81f7dcab62b40d03ad96d666e1ca 02:30:01 INFO - mozversion INFO | application_display_name: Nightly 02:30:01 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:30:01 INFO - mozversion INFO | application_name: Firefox 02:30:01 INFO - mozversion INFO | application_remotingname: firefox 02:30:01 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 02:30:01 INFO - mozversion INFO | application_vendor: Mozilla 02:30:01 INFO - mozversion INFO | application_version: 45.0a1 02:30:01 INFO - mozversion INFO | platform_buildid: 20151105005737 02:30:01 INFO - mozversion INFO | platform_changeset: c951580b6f9b81f7dcab62b40d03ad96d666e1ca 02:30:01 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 02:30:01 INFO - mozversion INFO | platform_version: 45.0a1 02:30:01 INFO - 2015-11-05 02:30:01,043 DEBUG : using testdate: 1446719401 02:30:01 INFO - 2015-11-05 02:30:01,043 DEBUG : actual date: 1446719401 02:30:01 INFO - 2015-11-05 02:30:01,054 INFO : starting webserver on 'localhost:49269' 02:30:01 INFO - 2015-11-05 02:30:01,055 INFO : Starting test suite t-yosemite-r5-0083.e 02:30:01 INFO - 2015-11-05 02:30:01,055 INFO : Starting test dromaeo_css 02:30:01 INFO - 2015-11-05 02:30:01,055 DEBUG : operating with platform_type : mac_ 02:30:01 INFO - 2015-11-05 02:30:01,056 INFO : Initialising browser for dromaeo_css test... 02:30:01 INFO - 2015-11-05 02:30:01,086 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/T/tmpRYFLMF/profile http://localhost:49269/getInfo.html 02:30:05 INFO - 2015-11-05 02:30:05,815 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:30:05 INFO - 2015-11-05 02:30:05,815 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:30:05 INFO - 2015-11-05 02:30:05,815 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 02:30:05 INFO - 2015-11-05 02:30:05,815 DEBUG : BROWSER_OUTPUT: __metrics 02:30:06 INFO - 2015-11-05 02:30:06,579 INFO : Browser initialized. 02:30:06 INFO - 2015-11-05 02:30:06,579 INFO : Running cycle 1/1 for dromaeo_css test... 02:30:06 INFO - 2015-11-05 02:30:06,579 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/T/tmpRYFLMF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:30:18 INFO - 2015-11-05 02:30:18,809 DEBUG : BROWSER_OUTPUT: RSS: Main: 233074688 02:30:18 INFO - 2015-11-05 02:30:18,809 DEBUG : BROWSER_OUTPUT: 02:31:08 INFO - 2015-11-05 02:31:08,695 DEBUG : BROWSER_OUTPUT: 1446719468691 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] 02:33:19 INFO - 2015-11-05 02:33:19,389 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49269/tests/dromaeo/cssquery-ext.html) 02:33:20 INFO - 2015-11-05 02:33:20,463 DEBUG : BROWSER_OUTPUT: RSS: Main: 256708608 02:33:20 INFO - 2015-11-05 02:33:20,464 DEBUG : BROWSER_OUTPUT: 02:36:22 INFO - 2015-11-05 02:36:22,604 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-ext.html (next: http://localhost:49269/tests/dromaeo/cssquery-jquery.html) 02:36:23 INFO - 2015-11-05 02:36:23,192 DEBUG : BROWSER_OUTPUT: RSS: Main: 263692288 02:36:23 INFO - 2015-11-05 02:36:23,192 DEBUG : BROWSER_OUTPUT: 02:39:24 INFO - 2015-11-05 02:39:24,931 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49269/tests/dromaeo/cssquery-mootools.html) 02:39:25 INFO - 2015-11-05 02:39:25,523 DEBUG : BROWSER_OUTPUT: RSS: Main: 266838016 02:39:25 INFO - 2015-11-05 02:39:25,523 DEBUG : BROWSER_OUTPUT: 02:42:27 INFO - 2015-11-05 02:42:27,333 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49269/tests/dromaeo/cssquery-prototype.html) 02:42:27 INFO - 2015-11-05 02:42:27,920 DEBUG : BROWSER_OUTPUT: RSS: Main: 272138240 02:42:27 INFO - 2015-11-05 02:42:27,920 DEBUG : BROWSER_OUTPUT: 02:45:30 INFO - 2015-11-05 02:45:30,569 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49269/tests/dromaeo/cssquery-yui.html) 02:45:31 INFO - 2015-11-05 02:45:31,181 DEBUG : BROWSER_OUTPUT: RSS: Main: 276164608 02:45:31 INFO - 2015-11-05 02:45:31,181 DEBUG : BROWSER_OUTPUT: 02:48:33 INFO - 2015-11-05 02:48:33,844 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-yui.html (next: http://localhost:49269/tests/dromaeo/cssquery-dojo.html) 02:48:34 INFO - 2015-11-05 02:48:34,096 DEBUG : BROWSER_OUTPUT: RSS: Main: 282152960 02:48:34 INFO - 2015-11-05 02:48:34,096 DEBUG : BROWSER_OUTPUT: 02:48:34 INFO - 2015-11-05 02:48:34,097 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:48:34 INFO - 2015-11-05 02:48:34,097 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:48:34 INFO - 2015-11-05 02:48:34,097 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:48:34 INFO - 2015-11-05 02:48:34,097 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:48:34 INFO - 2015-11-05 02:48:34,101 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2537.2515108043126;2570.5373032854086;2588.2235329401187;2597.480503899221;2650.2579277802224;4253.106847562008;4274.059706864488;4314.805833737481;4317.373980772786;4372.081862808814;4210.6631469482445;4240.809163587638;4317.827286908519;4347.913041739163;4439.5560443955665;3915.647591716745;4045.63589276965;4054.2904991626497;4092.1815636872598;4135.834566617332;3994.241094192109;4060.939085913714;4069.552349241581;4105.630493255607;4113.321301985169;3875.61243875613;3984.2230765000836;4005.7796821174825;4023.3361495353233;4076.7350122242105;3834.884953451401;3923.058465968176;3958.5447673517624;4002.079521710023;4034.515858097018;3938.7439816411843;3959.425883246942;4047.817848196809;4075.3886916962397;4094.549599544048;3998.900027499307;4182.728122672017;4198.6641068714425;4207.894802629929;4229.851955181584;4583.404157459542;4584.816607335736;4630.86107416778;4658.930116048262;4700.012997270577;4622.884427889296;4634.165850146972;4667.6732628716;4678.274867395559;4686.039361930796;4058.2695114879607;4145.97927010363;4205.285101532747;4231.30183519722;4395.934060989088;4716.033213191287;4717.8348757794;4736.9884231219485;4786.832460863853;4801.567858892717;4518.480374756945;4536.319552067216;4553.681242313072;4590.013147173374;4654.883627909262;4259.574042595777;4506.729596224237;4532.410786597721;4590.495045544987;4613.469451013109;4541.477730061019;4591.79336929839;4612;4614.2617181250835;4659.091477161921;4395.604395604411;4570.4743954445;4580.610648094949;4582.885427864263;4676.859694209179;3521.9295614087573;3566.251087271702;3657.8719744809337;3674.6876515496483;3680.2087551176623;3244.23760416302;3246.4967929970894;3282.113829266085;3283.228441316289;3303.6861498157637;4151.12826306473;4284.485861696617;4325.632321252729;4374.868753937387;4397.362382454527;4509.481409637868;4561.347743165919;4608.446986361658;4611;4625.121226966866;4262.360645903139;4286.764227967429;4315.223259813264;4322.330038843984;4328.329108988112;3948.5853985331128;4007.338789099824;4049.655779258737;4059.3910913363234;4074.714769966133;4641.512641172696;4644.512326205835;4650.302454631832;4671.416072990876;4785.569298763128;4616.192166370939;4634.443866736014;4695.624350052056;4725.527447255247;4734.242521196592;4440.4227450431235;4509.413776209072;4524.683272170916;4599.448066232074;4610.608098311681;4547.590716835369;4553.79507922151;4567.885802854955;4608.884777880446;4638.83764068256;4522.005158865044;4658.720476771405;4668;4697.13103075932;4713.457952335525;4175.958240417557;4332.935005974849;4432.445944256968;4434.889127771831;4500.9099818004115;4434.17967675981;4461.776911154494;4492.056668099735;4555.066211426716;4565.315202719618;4164.979175104105;4235.1317979814685;4423.60187583119;4446.933296000498;4456.17560751262;4314;4403.119376124852;4425.933610995773;4438.66709996758;4440.533743956968;4407.647388208871;4427.667924905581;4432.11357728462;4487.887802804956;4495.483019452674 02:48:34 INFO - 2015-11-05 02:48:34,102 DEBUG : BROWSER_OUTPUT: |1;ext.html;443.9755813430261;444.8465279478581;462.4496848749988;472.76361819090454;475.67891673120613;30535.236619084535;31542.526862097086;31677.624178186612;31933;32264;32399.190020249505;33036.33927321452;33131.83434082826;33278.83360583194;33459.665403345956;7228.783136505913;7336.963315183417;7349.228331025246;7408.888866667005;7548.094228692565;7240.5293655912465;7300.160481544637;7310.195878453366;7342.596157211351;7377.741779037735;6741.831454213635;6744.9325506745045;6747.898781518281;6789.01559273905;6839.1451068616425;7259.382952449048;7340.743073992411;7384.667689953965;7421.369183619398;7437.219091995316;7073.434125269966;7251.746188883417;7295.161056478467;7309.269073092702;7360.116785985662;30664.84667576648;31267;31279.37441251185;31561.21096972594;31603.683963160303;2428.647846062311;2503.0113105323294;2551.7065537463245;2734.753872151516;2836.858157092158;21453.67819482709;21880.23419180321;22086.11655533793;22253.554928901493;23251;1906.3423119023914;1914.5405102775233;1926.9132889019888;1966.4985428715586;1990.2536548794203;216308;217126.99999999843;217421;221051;221538;42297.36553951693;42488.15023699571;45207.321890171675;46037.53962460333;49581.752091240036;47869.5213047872;47899;47979;48394.27408588874;48955;11577.76844463106;11663.59177428786;11768.646940591796;11947;12019.939900300442;8902.821943561223;8913;8913.465192088366;9052.592633331516;9072.637094516278;14543.85456145425;14793.556193314218;14886.404543818342;14916.328765205591;15117.244137793066;6266.965950618188;6433.292337842833;6465.806025819233;6541.803745887631;6542.378474044958;778.4667502760627;807.5598798654747;869.2654706772767;886.9932626468875;927.2720914082413;22557.54884902293;22618.66072008921;22635.320940371486;22672.773272267397;22956.311310660705;796.2197046894076;828.9875651865227;838.828040251747;842.4608250719544;842.5787106446777;11888.395066666062;12221.327826969602;12409.317487538092;12504.687382815502;12604.55884044054;229697;230854;237831;238030;238048;42799.572004280184;42889.35665965013;43117.35323970143;43796.78101609535;43850;1093.8851420600881;1124.8987591116838;1127.7180704823795;1129.3167633581565;1133.8129208680475;22279.10883564639;22409.32772016842;22715;22772.4306892329;23193;36723.44914826226;37013.62986370102;37024.07439814026;37627.81186094052;37638;227824;230564;233807;234815;235102;23254.534909302056;33784;34872.30255394827;35187.296254075285;35801.64198357983;36755;36940.44589331109;37105.44341834821;37275;37382.62617373792;30030.699693003666;31047.223819404695;31489.37021259516;31609.52585711262;31762.205944851565;29736;30994.84502577563;31051.534226987063;31142.844285778425;31282.68717312798;31725.5241171378;31948.36103277875;32178.356432870743;32378.67621323851;33352.14757021576;25959.351016224744;26525.469490610467;27701.30746731348;27728.722712772615;27840.721592784623;20345.6948145775;20680.276190333265;21075.8946205268;21120.894395527925;21147.577048458636 02:48:34 INFO - 2015-11-05 02:48:34,106 DEBUG : BROWSER_OUTPUT: |2;jquery.html;270.8496784284722;272.97543221110095;273.55001023316635;276.3864221428429;276.6762887421715;10936.234463587552;13740.450381984721;14086.943479239073;14428.639284017892;14441.927790361047;9162.633494660222;9470.38442501237;9662.082102200297;14594.343254553543;15091.62270943227;3511.315293517765;3556.430971044633;3567.6075631680496;3622.5834029086595;3635.836387362575;3496.440569508879;3511.385507536184;3525.400681884073;3592.263585964884;3602.1534939289245;2656.734326567347;2756.6554180727408;3415.573053368329;3488.180277634754;3712.554493460775;3736.159364143073;3766.679832214265;3792.2036372361977;3829.4064420014943;3894.6689531389866;3161.920951976219;3210;3248.5289633003317;3248.545203671488;3251.463508521091;10261.127804136657;10621.2034097443;10666.573337066508;10667.039966402983;10823.621173258976;1367.4256812138926;1462.5977856089555;1498.9475368362164;1538.5076775431867;1635.1497221444902;7483.625818709097;7580.317771400545;7623.466357354987;7666.3100320970825;7894.763157105296;1228.3121451986915;1228.9938550307281;1236.6537369536545;1251.6557946564676;1276.7446510697898;44463.55536444626;44990.77504612489;45046.32430513545;45261.32108018382;46572.76713616444;5045.142325804622;5167.3799144102195;5174.404943431554;5202.947970520247;5208.713520756319;5909.084091965667;5953.672548009901;5978.103284507359;6047.395260474005;6056.697165141725;4151.730137541111;4241.703080784316;4245.405643209953;4265.87202383929;4315.848945286963;4443.4445694288215;4456.799444025027;4459.598636122764;4468.776561171929;4532.524084971096;2282.44080200352;2328.0804082387363;2367.988160059189;2373.727021392562;2382.7855493005713;824.9257566819015;837.9622916968751;838.4550042472441;842.3219308456751;880.295763389286;325.71667629539536;344.2941968963615;345.623270635009;349.8128501251818;370.26871927942636;7968.681252749825;8421.073681894986;8897.644094236159;8968.192862642394;9100.31747618918;362.4617443096999;371.6283716283716;374.4233879825093;379.2642273988454;379.55402402177884;4882.292067650242;4940.950590494121;5080.822171224063;5118.923216151761;5143.099957507421;341320;411910;420652;421282;427608;58024.12963805546;58029.4197058024;58137;58555;58599;399.1398536154592;403.61051585220406;404.4297540467926;405.3575083492697;410.8295057551083;8463.280621147025;8659.00421451516;8806.779830504032;8817.823643526965;9013.414128081653;27694;28221.294467638472;28257;29017;29034.564481533216;33780.15549611279;35101;35775;36298;37141.0714732123;4741.336212930123;4957.652964292609;4962.8759281018265;4998.750062496788;4999.300097986212;9048.095190480899;9324.160825525736;9512.90487095148;9547.42715437076;9716.368436051634;8087.959560202161;8088.636011379384;8193.67225310981;8221;8305.709300174465;7941.880871786812;7951.642176102205;8008.559529225949;8062.1534738853925;8077.031777591502;8104;8271.669133234844;8285.088640249447;8389.035260944825;8551.486910785372;4872.731999740048;4903.239997800204;4917.9016419672125;4942.5304596063315;4997.425296090996;7873.566953817595;8215.835683286181;8263.380246481418;8281.917180828355;8282.627281772215 02:48:34 INFO - 2015-11-05 02:48:34,106 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1404.3961096728406;1440.4886265375792;1444.40779280495;1447.4210315873652;1491.746403111471;5213.3743950725875;5375.301210842585;5773.653580785151;5955.0769630707255;6112.816615501531;5576.972115139419;5666.57500687448;5736.368999410061;5742.196092547047;5879.235699359088;1730.178165371448;1732.0300631646319;1734.9392771253008;1747.8164792696712;1767.6729804986055;1722.6296346285546;1731;1753.4213709475841;1759.8680098992563;1773.219783295346;1707.436545939843;1726.2059452651795;1739.2868923741269;1749.1254372813594;1762.5769815244314;1692.5091723400199;1694.1190580897864;1697.7198762204284;1700.4813531872774;1716.9313227470886;1712.049812354143;1726.6201435684254;1728.6197036651915;1747.2224859937332;1755.4821327708357;5801.767929282823;5842.24050873388;5872.735726892257;5953.553483488712;5958.851028724316;3545.8227088645463;3622.5834029086463;3644.2711457708565;3687;3690.464882592009;1969.3993332033724;2048.6722124460166;2213.645816669325;2275.84069115162;2297.6438652008965;705.5731282574071;759.5556599389364;778.6534991928594;785.9882101768478;1199.2264989081993;7324.121105467378;7352.632368381613;7367.410607151469;7443.995060666849;7507.3243408092985;3061.7397521210946;3153.858076386568;3188.9043328700177;3203.3112880730755;3246.62663793662;6166.383361663798;6244.000959846494;6244.469220116341;6302.401271879256;6349;3532.717382609385;3537.7346698997676;3544.0608238816735;3607.549056367954;3609.5668519777796;3293.720033797106;3346.0129261867805;3351.648076951885;3354.580677415323;3355.832208389571;2583.8062145339177;2599.519088968509;2625.3174174714713;2651.350419147321;2677.170077276012;779.1818590479974;786.8741001439743;788.0543347982444;789.644659903046;796.8127490039836;1029.3000759483623;1035.2701345551368;1042.7080417483116;1046.2310202001522;1101.5098281264761;5492.862678433071;5506.91739623906;5537.612367134342;5555.2500412444615;5677.091665333527;375.22141556270844;379.6791711004197;380.36858814368014;380.78485655604493;381.2831876072965;4410.514843367227;4470.284754439274;4480.775961201927;4491.932621010687;4555.157295900269;6222.62664240147;6245.469135123474;6582.80251592453;6727.495437842083;6852.794416167523;6555.04951781989;6633.204015518072;6671.3328667133865;6677.833054173684;6702.865942681216;5402.594805389612;5433.782648694087;5445.37378201504;5527.060399732055;5546.55627549795;5119.46245644202;5340.919886201787;5345.732713364238;5366.7048312343195;5439.918401224064;5775.537956963349;6074.635521868702;6095.969520152371;6097.2683278006925;6186.597871138361;6112.663803490851;6121.234845644294;6122.479589234965;6129.478994285536;6173.9073913892225;5098.97450512745;5146.202338637517;5186.9221961669855;5190.55880250183;5210.853612205309;5525.889482210253;5547.972260138674;5555.472230138131;5558.44415558441;5656.038473459604;5077.695338279715;5236.266922630911;5282.920756188583;5383.542398895981;5392.218128371443;5052.873678158076;5105.412877519133;5180.378354597472;5232.947670523246;5326.760295786621;5221.399539052905;5255.185446255837;5257.868553286198;5297.629165958346;5337.412884582771;4806.567408933212;4822.734749588666;4837.0084132752;4849.781759820887;4883.755812209446;4772.49888761675;4883.218685010382;4891.706497610155;4935.555799978019;4978 02:48:34 INFO - 2015-11-05 02:48:34,110 DEBUG : BROWSER_OUTPUT: |4;prototype.html;251.26755507695069;252.3162230355737;257.94196305831184;259.1577373536008;262.1571647154398;4879.53644403782;4911.484294149116;4942.233953737176;4968.577670897974;4992.525710057544;4743.075100355432;4859.538343857337;4887.584555312803;4903.509649035094;4976.751162441881;3735.477033215352;3739.1773809761876;3748.8125593720342;3750.2124553843723;3802.6007269236748;3703.7962912039825;3732.7387082904206;3781.4327850822324;3809.771413715172;3811.866584669537;3691.243295124493;3697.870574529892;3713.758605690635;3726.273376691546;3759.9436008459893;3607.116256517157;3678.3746763050344;3693.353663108945;3712.2389910068373;3777.773333599979;3127.6559578446354;3160.083575763026;3188.4420226460275;3192.632847222576;3224.2100685332243;4723.244280915072;4733.124371991193;4735.360726301939;4858.052679727454;4866.78099485524;4159.500859896832;4159.667226621863;4163.5628259032665;4246.6602671786495;4270.850520231808;4950.331705219821;4951.801927922878;4984.22744474607;5149.845504634867;5255.500727430888;3386.136535183537;3400.96599034009;3401.557797486336;3407.2333724911946;3454.844531996066;5358.196270559409;5358.973205133989;5373.194020896896;5446.945530544723;5453.454654534515;3453.223024819446;3468.722502199818;3472.6700963408434;3478.060923550627;3544.220271540257;3475.860965561349;3532.1875968527384;3539.7876127432437;3569.196930690626;3596.6583174598372;3949.92100158001;3971.3447281198855;4107.034846810997;4136.193442278727;4223.619874211336;5084.059449001947;5087.16061849798;5108.489151084936;5158.174692049254;5204.739763011834;1259.7921342978307;1286.9613911582667;1289.9806502902463;1299.3048718935324;1305.3016636099642;813.6704634622869;826.6486743134144;830.8172202115525;834.1241696218946;845.5222799118478;4965.726885021286;4967.82612608557;4997.3253610762085;5078;5080.212567052113;5400.378956419983;5413.458654134555;5474.616776825664;5476.780928762884;5524.392316845144;4949.455559888409;4983.9252411213865;5021.949780502148;5033.6224783141415;5049.520295571915;2878.266042159236;2946.528555431121;2994.0419065898705;3007.6090108285784;3053.0382929377174;5430.5384042356845;5484.122540393518;5521.033819081645;5543;5553.694546799965;5537.612367134342;5574.916376254359;5619.522340601013;5644.6613203207935;5656.745446454919;5448.101063324507;5534.612577119563;5541.750621221974;5543.307086614173;5558.805441809517;5254.290670759551;5409.945900540944;5422.213779001943;5492.176173573996;5507.531859791802;5346.8395948121615;5347.0375332440535;5376.274202982548;5381.2197231402015;5387.784488620411;5444.6188766785945;5529.060059789926;5534.723263836711;5549.5837812163445;5561.026820306511;3552.5381700378784;3571.6964058055355;3586.870135907181;3591.048372181426;3596.6583174598372;5184.974075129751;5284.128118860345;5374.355077390738;5432.130859062531;5490.231367608458;5087.287779710918;5133.717645529532;5144.871378215575;5239.371275446971;5243.606729495379;5180.300659410931;5205.06308864408;5211.687298762086;5231.738413079407;5259.47405259471;5045.419776725576;5151.072806894795;5154.61340399479;5168.457311982338;5178.223266510054;4990.50094990498;5179.637425380338;5285.075111855333;5287.154055351125;5391.353037635509;5121.283020377075;5173.042987047408;5180.119379705384;5241.030409374278;5256.132738098171 02:48:34 INFO - 2015-11-05 02:48:34,111 DEBUG : BROWSER_OUTPUT: |5;yui.html;579.3771695427416;584.9122631605259;613.4908026338138;624.4068135271492;629.5844742469965;10956.5617375305;12489.750204995906;12565.057620678463;12608.180468269557;12968.675783105427;11522;11542.711432214199;11661.70845728855;11696.824547631792;11746.471408786603;546.4890327543759;556.7578103524979;691.2223748283182;692.6536731634183;718.5509056839476;682.8600136971909;690.5131882023162;695.5131408014411;699.1435491522894;705.9858802823941;725.989110163348;726.1177669132004;726.920038795732;732.9560226386408;737.5390381011867;664.8271449423137;709.6026225313789;714.878470659989;716.5306724095726;723.7141329174973;517.3920643244173;522.9843104706865;525.7134861500491;527.2565682387853;528.7488442989587;10560.26078174528;10591.364518128938;10611.734706632318;10771.299865508796;10790.67627971162;7541.283578060075;7657.540547567108;7759.816157533937;7869.370450363957;8091.878621820678;7109.6445177741425;7136.143662760502;7217.458690598226;7279.012148337602;7609.010828592303;2261.869362672214;2396.1733202045266;2419.2621250518587;2467.938301542476;2477.3930387055107;36281.81859090714;36387.4541881872;36470.8176459116;36598.8170059148;36935.261294773954;4968.503149685002;5028.421731500925;5054.292399064134;5138.946515964219;5276.5251127398715;9074.092590741006;9508.572114254875;9540.14138727504;9541.332106752461;9552.761180970392;4800.783964721596;4826.806927722922;5010.123228435083;5063.316452278968;5075.467075956972;3036.4686179918426;3099.5195744659613;3150.6691797361404;3257.990023092849;3353.094664440587;2097.517570958688;2123.373604786592;2125.6811478278382;2137.10241698487;2144.249512670584;312.4189008444292;313.56414583728633;322.7659946538741;324.79375596496396;330.6049271120987;425.3768229543671;473.1908436573498;479.26911460023047;483.97638993529137;490.9484504127015;6345.460635846005;6491;6491.415772580491;7014.473914456335;7113.288671132948;386.4454507781343;476.9356136921471;478.818049141331;488.2919766338823;489.70617629422776;3004.4892368297005;3039.937805862602;3163.4463968805367;3167.7149056585017;3202.343519578481;48041;48137;48709.26936095962;48828.755856220494;49186;36567.26865462676;37578.06054848596;40516.797416012734;41464.58535414668;41724.1655166895;38896;39505.60494395077;40353.99115022089;40375.39436908449;41184.79407602943;6712.496562757715;6758.93241067583;6815;6863.691133899087;6940.861182776417;27302.269773022537;27801.887924483603;27924.58113128264;28104.71895281103;28344.433111337246;32531.34937301288;36599.63400365962;36671.81664091662;37079.443808343436;37209.069773255884;8583.18459746323;8598.33750865355;8600.268977136762;8692.739217823475;8695.173958473935;8669.476219145103;8825.779355516164;8928.464292142493;8968.327375446737;9101.499417532099;8468.195521425454;8514.276286515715;8524.062353141273;8670.13298670128;8764.21122099014;8329.95835020821;8480.406371553932;8564.871526926976;8577.386170586995;8598.656053757779;8137.267645911897;8315.126911674188;8467.61895714682;8472.788180295542;8552.102029287083;7060.505764596429;7228.855422891618;7372.594507301936;7410.407167426485;7467.663955121924;6577;6925.134358205224;6990.335918087773;7303.8539229216185;7453 02:48:34 INFO - 2015-11-05 02:48:34,112 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:48:34 INFO - 2015-11-05 02:48:34,112 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:48:34 INFO - 2015-11-05 02:48:34,112 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,310 02:48:34 INFO - 2015-11-05 02:48:34,112 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:48:34 INFO - 2015-11-05 02:48:34,112 DEBUG : BROWSER_OUTPUT: __startTimestamp1446720514096__endTimestamp 02:48:34 INFO - 2015-11-05 02:48:34,113 DEBUG : BROWSER_OUTPUT: 02:48:34 INFO - 2015-11-05 02:48:34,113 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:48:34 INFO - 2015-11-05 02:48:34,113 DEBUG : BROWSER_OUTPUT: Number of tests: 6 02:48:34 INFO - 2015-11-05 02:48:34,113 DEBUG : BROWSER_OUTPUT: 02:48:34 INFO - 2015-11-05 02:48:34,113 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4280.64 Median:4407.65 stddev:445.84 (10.1%) stddev-sans-first:425.71 02:48:34 INFO - 2015-11-05 02:48:34,114 DEBUG : BROWSER_OUTPUT: Values: 2537.3 2570.5 2588.2 2597.5 2650.3 4253.1 4274.1 4314.8 4317.4 4372.1 4210.7 4240.8 4317.8 4347.9 4439.6 3915.6 4045.6 4054.3 4092.2 4135.8 3994.2 4060.9 4069.6 4105.6 4113.3 3875.6 3984.2 4005.8 4023.3 4076.7 3834.9 3923.1 3958.5 4002.1 4034.5 3938.7 3959.4 4047.8 4075.4 4094.5 3998.9 4182.7 4198.7 4207.9 4229.9 4583.4 4584.8 4630.9 4658.9 4700.0 4622.9 4634.2 4667.7 4678.3 4686.0 4058.3 4146.0 4205.3 4231.3 4395.9 4716.0 4717.8 4737.0 4786.8 4801.6 4518.5 4536.3 4553.7 4590.0 4654.9 4259.6 4506.7 4532.4 4590.5 4613.5 4541.5 4591.8 4612.0 4614.3 4659.1 4395.6 4570.5 4580.6 4582.9 4676.9 3521.9 3566.3 3657.9 3674.7 3680.2 3244.2 3246.5 3282.1 3283.2 3303.7 4151.1 4284.5 4325.6 4374.9 4397.4 4509.5 4561.3 4608.4 4611.0 4625.1 4262.4 4286.8 4315.2 4322.3 4328.3 3948.6 4007.3 4049.7 4059.4 4074.7 4641.5 4644.5 4650.3 4671.4 4785.6 4616.2 4634.4 4695.6 4725.5 4734.2 4440.4 4509.4 4524.7 4599.4 4610.6 4547.6 4553.8 4567.9 4608.9 4638.8 4522.0 4658.7 4668.0 4697.1 4713.5 4176.0 4332.9 4432.4 4434.9 4500.9 4434.2 4461.8 4492.1 4555.1 4565.3 4165.0 4235.1 4423.6 4446.9 4456.2 4314.0 4403.1 4425.9 4438.7 4440.5 4407.6 4427.7 4432.1 4487.9 4495.5 02:48:34 INFO - 2015-11-05 02:48:34,115 DEBUG : BROWSER_OUTPUT: 02:48:34 INFO - 2015-11-05 02:48:34,115 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:37046.01 Median:31940.68 stddev:59647.07 (186.7%) stddev-sans-first:59751.09 02:48:34 INFO - 2015-11-05 02:48:34,116 DEBUG : BROWSER_OUTPUT: Values: 444.0 444.8 462.4 472.8 475.7 30535.2 31542.5 31677.6 31933.0 32264.0 32399.2 33036.3 33131.8 33278.8 33459.7 7228.8 7337.0 7349.2 7408.9 7548.1 7240.5 7300.2 7310.2 7342.6 7377.7 6741.8 6744.9 6747.9 6789.0 6839.1 7259.4 7340.7 7384.7 7421.4 7437.2 7073.4 7251.7 7295.2 7309.3 7360.1 30664.8 31267.0 31279.4 31561.2 31603.7 2428.6 2503.0 2551.7 2734.8 2836.9 21453.7 21880.2 22086.1 22253.6 23251.0 1906.3 1914.5 1926.9 1966.5 1990.3 216308.0 217127.0 217421.0 221051.0 221538.0 42297.4 42488.2 45207.3 46037.5 49581.8 47869.5 47899.0 47979.0 48394.3 48955.0 11577.8 11663.6 11768.6 11947.0 12019.9 8902.8 8913.0 8913.5 9052.6 9072.6 14543.9 14793.6 14886.4 14916.3 15117.2 6267.0 6433.3 6465.8 6541.8 6542.4 778.5 807.6 869.3 887.0 927.3 22557.5 22618.7 22635.3 22672.8 22956.3 796.2 829.0 838.8 842.5 842.6 11888.4 12221.3 12409.3 12504.7 12604.6 229697.0 230854.0 237831.0 238030.0 238048.0 42799.6 42889.4 43117.4 43796.8 43850.0 1093.9 1124.9 1127.7 1129.3 1133.8 22279.1 22409.3 22715.0 22772.4 23193.0 36723.4 37013.6 37024.1 37627.8 37638.0 227824.0 230564.0 233807.0 234815.0 235102.0 23254.5 33784.0 34872.3 35187.3 35801.6 36755.0 36940.4 37105.4 37275.0 37382.6 30030.7 31047.2 31489.4 31609.5 31762.2 29736.0 30994.8 31051.5 31142.8 31282.7 31725.5 31948.4 32178.4 32378.7 33352.1 25959.4 26525.5 27701.3 27728.7 27840.7 20345.7 20680.3 21075.9 21120.9 21147.6 02:48:34 INFO - 2015-11-05 02:48:34,116 DEBUG : BROWSER_OUTPUT: 02:48:34 INFO - 2015-11-05 02:48:34,117 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:20403.62 Median:215961.92 stddev:66533.78 (30.8%) stddev-sans-first:66703.25 02:48:34 INFO - 2015-11-05 02:48:34,118 DEBUG : BROWSER_OUTPUT: Values: 270.8 273.0 273.6 276.4 276.7 10936.2 13740.5 14086.9 14428.6 14441.9 9162.6 9470.4 9662.1 14594.3 15091.6 3511.3 3556.4 3567.6 3622.6 3635.8 3496.4 3511.4 3525.4 3592.3 3602.2 2656.7 2756.7 3415.6 3488.2 3712.6 3736.2 3766.7 3792.2 3829.4 3894.7 3161.9 3210.0 3248.5 3248.5 3251.5 10261.1 10621.2 10666.6 10667.0 10823.6 1367.4 1462.6 1498.9 1538.5 1635.1 7483.6 7580.3 7623.5 7666.3 7894.8 1228.3 1229.0 1236.7 1251.7 1276.7 44463.6 44990.8 45046.3 45261.3 46572.8 5045.1 5167.4 5174.4 5202.9 5208.7 5909.1 5953.7 5978.1 6047.4 6056.7 4151.7 4241.7 4245.4 4265.9 4315.8 4443.4 4456.8 4459.6 4468.8 4532.5 2282.4 2328.1 2368.0 2373.7 2382.8 824.9 838.0 838.5 842.3 880.3 325.7 344.3 345.6 349.8 370.3 7968.7 8421.1 8897.6 8968.2 9100.3 362.5 371.6 374.4 379.3 379.6 4882.3 4941.0 5080.8 5118.9 5143.1 341320.0 411910.0 420652.0 421282.0 427608.0 58024.1 58029.4 58137.0 58555.0 58599.0 399.1 403.6 404.4 405.4 410.8 8463.3 8659.0 8806.8 8817.8 9013.4 27694.0 28221.3 28257.0 29017.0 29034.6 33780.2 35101.0 35775.0 36298.0 37141.1 4741.3 4957.7 4962.9 4998.8 4999.3 9048.1 9324.2 9512.9 9547.4 9716.4 8088.0 8088.6 8193.7 8221.0 8305.7 7941.9 7951.6 8008.6 8062.2 8077.0 8104.0 8271.7 8285.1 8389.0 8551.5 4872.7 4903.2 4917.9 4942.5 4997.4 7873.6 8215.8 8263.4 8281.9 8282.6 02:48:34 INFO - 2015-11-05 02:48:34,118 DEBUG : BROWSER_OUTPUT: 02:48:34 INFO - 2015-11-05 02:48:34,119 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4027.94 Median:5132.83 stddev:2019.46 (39.3%) stddev-sans-first:2015.50 02:48:34 INFO - 2015-11-05 02:48:34,120 DEBUG : BROWSER_OUTPUT: Values: 1404.4 1440.5 1444.4 1447.4 1491.7 5213.4 5375.3 5773.7 5955.1 6112.8 5577.0 5666.6 5736.4 5742.2 5879.2 1730.2 1732.0 1734.9 1747.8 1767.7 1722.6 1731.0 1753.4 1759.9 1773.2 1707.4 1726.2 1739.3 1749.1 1762.6 1692.5 1694.1 1697.7 1700.5 1716.9 1712.0 1726.6 1728.6 1747.2 1755.5 5801.8 5842.2 5872.7 5953.6 5958.9 3545.8 3622.6 3644.3 3687.0 3690.5 1969.4 2048.7 2213.6 2275.8 2297.6 705.6 759.6 778.7 786.0 1199.2 7324.1 7352.6 7367.4 7444.0 7507.3 3061.7 3153.9 3188.9 3203.3 3246.6 6166.4 6244.0 6244.5 6302.4 6349.0 3532.7 3537.7 3544.1 3607.5 3609.6 3293.7 3346.0 3351.6 3354.6 3355.8 2583.8 2599.5 2625.3 2651.4 2677.2 779.2 786.9 788.1 789.6 796.8 1029.3 1035.3 1042.7 1046.2 1101.5 5492.9 5506.9 5537.6 5555.3 5677.1 375.2 379.7 380.4 380.8 381.3 4410.5 4470.3 4480.8 4491.9 4555.2 6222.6 6245.5 6582.8 6727.5 6852.8 6555.0 6633.2 6671.3 6677.8 6702.9 5402.6 5433.8 5445.4 5527.1 5546.6 5119.5 5340.9 5345.7 5366.7 5439.9 5775.5 6074.6 6096.0 6097.3 6186.6 6112.7 6121.2 6122.5 6129.5 6173.9 5099.0 5146.2 5186.9 5190.6 5210.9 5525.9 5548.0 5555.5 5558.4 5656.0 5077.7 5236.3 5282.9 5383.5 5392.2 5052.9 5105.4 5180.4 5232.9 5326.8 5221.4 5255.2 5257.9 5297.6 5337.4 4806.6 4822.7 4837.0 4849.8 4883.8 4772.5 4883.2 4891.7 4935.6 4978.0 02:48:34 INFO - 2015-11-05 02:48:34,120 DEBUG : BROWSER_OUTPUT: 02:48:34 INFO - 2015-11-05 02:48:34,120 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4324.20 Median:4987.36 stddev:1335.83 (26.8%) stddev-sans-first:1304.13 02:48:34 INFO - 2015-11-05 02:48:34,121 DEBUG : BROWSER_OUTPUT: Values: 251.3 252.3 257.9 259.2 262.2 4879.5 4911.5 4942.2 4968.6 4992.5 4743.1 4859.5 4887.6 4903.5 4976.8 3735.5 3739.2 3748.8 3750.2 3802.6 3703.8 3732.7 3781.4 3809.8 3811.9 3691.2 3697.9 3713.8 3726.3 3759.9 3607.1 3678.4 3693.4 3712.2 3777.8 3127.7 3160.1 3188.4 3192.6 3224.2 4723.2 4733.1 4735.4 4858.1 4866.8 4159.5 4159.7 4163.6 4246.7 4270.9 4950.3 4951.8 4984.2 5149.8 5255.5 3386.1 3401.0 3401.6 3407.2 3454.8 5358.2 5359.0 5373.2 5446.9 5453.5 3453.2 3468.7 3472.7 3478.1 3544.2 3475.9 3532.2 3539.8 3569.2 3596.7 3949.9 3971.3 4107.0 4136.2 4223.6 5084.1 5087.2 5108.5 5158.2 5204.7 1259.8 1287.0 1290.0 1299.3 1305.3 813.7 826.6 830.8 834.1 845.5 4965.7 4967.8 4997.3 5078.0 5080.2 5400.4 5413.5 5474.6 5476.8 5524.4 4949.5 4983.9 5021.9 5033.6 5049.5 2878.3 2946.5 2994.0 3007.6 3053.0 5430.5 5484.1 5521.0 5543.0 5553.7 5537.6 5574.9 5619.5 5644.7 5656.7 5448.1 5534.6 5541.8 5543.3 5558.8 5254.3 5409.9 5422.2 5492.2 5507.5 5346.8 5347.0 5376.3 5381.2 5387.8 5444.6 5529.1 5534.7 5549.6 5561.0 3552.5 3571.7 3586.9 3591.0 3596.7 5185.0 5284.1 5374.4 5432.1 5490.2 5087.3 5133.7 5144.9 5239.4 5243.6 5180.3 5205.1 5211.7 5231.7 5259.5 5045.4 5151.1 5154.6 5168.5 5178.2 4990.5 5179.6 5285.1 5287.2 5391.4 5121.3 5173.0 5180.1 5241.0 5256.1 02:48:34 INFO - 2015-11-05 02:48:34,121 DEBUG : BROWSER_OUTPUT: 02:48:34 INFO - 2015-11-05 02:48:34,121 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:10685.99 Median:524.35 stddev:13044.40 (2487.7%) stddev-sans-first:13058.91 02:48:34 INFO - 2015-11-05 02:48:34,122 DEBUG : BROWSER_OUTPUT: Values: 579.4 584.9 613.5 624.4 629.6 10956.6 12489.8 12565.1 12608.2 12968.7 11522.0 11542.7 11661.7 11696.8 11746.5 546.5 556.8 691.2 692.7 718.6 682.9 690.5 695.5 699.1 706.0 726.0 726.1 726.9 733.0 737.5 664.8 709.6 714.9 716.5 723.7 517.4 523.0 525.7 527.3 528.7 10560.3 10591.4 10611.7 10771.3 10790.7 7541.3 7657.5 7759.8 7869.4 8091.9 7109.6 7136.1 7217.5 7279.0 7609.0 2261.9 2396.2 2419.3 2467.9 2477.4 36281.8 36387.5 36470.8 36598.8 36935.3 4968.5 5028.4 5054.3 5138.9 5276.5 9074.1 9508.6 9540.1 9541.3 9552.8 4800.8 4826.8 5010.1 5063.3 5075.5 3036.5 3099.5 3150.7 3258.0 3353.1 2097.5 2123.4 2125.7 2137.1 2144.2 312.4 313.6 322.8 324.8 330.6 425.4 473.2 479.3 484.0 490.9 6345.5 6491.0 6491.4 7014.5 7113.3 386.4 476.9 478.8 488.3 489.7 3004.5 3039.9 3163.4 3167.7 3202.3 48041.0 48137.0 48709.3 48828.8 49186.0 36567.3 37578.1 40516.8 41464.6 41724.2 38896.0 39505.6 40354.0 40375.4 41184.8 6712.5 6758.9 6815.0 6863.7 6940.9 27302.3 27801.9 27924.6 28104.7 28344.4 32531.3 36599.6 36671.8 37079.4 37209.1 8583.2 8598.3 8600.3 8692.7 8695.2 8669.5 8825.8 8928.5 8968.3 9101.5 8468.2 8514.3 8524.1 8670.1 8764.2 8330.0 8480.4 8564.9 8577.4 8598.7 8137.3 8315.1 8467.6 8472.8 8552.1 7060.5 7228.9 7372.6 7410.4 7467.7 6577.0 6925.1 6990.3 7303.9 7453.0 02:48:34 INFO - 2015-11-05 02:48:34,122 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:48:34 INFO - 2015-11-05 02:48:34,123 DEBUG : BROWSER_OUTPUT: 02:48:34 INFO - 2015-11-05 02:48:34,820 INFO : Browser exited with error code: 0 02:48:34 INFO - 2015-11-05 02:48:34,855 INFO : Completed test dromaeo_css (00:18:33) 02:48:34 INFO - 2015-11-05 02:48:34,855 INFO : Starting test kraken 02:48:34 INFO - 2015-11-05 02:48:34,855 DEBUG : operating with platform_type : mac_ 02:48:34 INFO - 2015-11-05 02:48:34,855 INFO : Initialising browser for kraken test... 02:48:34 INFO - 2015-11-05 02:48:34,871 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/T/tmpEZkVi4/profile http://localhost:49269/getInfo.html 02:48:38 INFO - 2015-11-05 02:48:38,465 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:48:38 INFO - 2015-11-05 02:48:38,466 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:48:38 INFO - 2015-11-05 02:48:38,466 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 02:48:38 INFO - 2015-11-05 02:48:38,466 DEBUG : BROWSER_OUTPUT: __metrics 02:48:39 INFO - 2015-11-05 02:48:39,223 INFO : Browser initialized. 02:48:39 INFO - 2015-11-05 02:48:39,224 INFO : Running cycle 1/1 for kraken test... 02:48:39 INFO - 2015-11-05 02:48:39,224 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/T/tmpEZkVi4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:48:51 INFO - 2015-11-05 02:48:51,461 DEBUG : BROWSER_OUTPUT: RSS: Main: 233803776 02:48:51 INFO - 2015-11-05 02:48:51,461 DEBUG : BROWSER_OUTPUT: 02:48:54 INFO - 2015-11-05 02:48:54,615 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection) 02:48:55 INFO - 2015-11-05 02:48:55,259 DEBUG : BROWSER_OUTPUT: RSS: Main: 252239872 02:48:55 INFO - 2015-11-05 02:48:55,260 DEBUG : BROWSER_OUTPUT: 02:48:58 INFO - 2015-11-05 02:48:58,425 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-dft) 02:48:59 INFO - 2015-11-05 02:48:59,032 DEBUG : BROWSER_OUTPUT: RSS: Main: 260083712 02:48:59 INFO - 2015-11-05 02:48:59,033 DEBUG : BROWSER_OUTPUT: 02:49:02 INFO - 2015-11-05 02:49:02,503 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-fft) 02:49:03 INFO - 2015-11-05 02:49:03,090 DEBUG : BROWSER_OUTPUT: RSS: Main: 259895296 02:49:03 INFO - 2015-11-05 02:49:03,090 DEBUG : BROWSER_OUTPUT: 02:49:05 INFO - 2015-11-05 02:49:05,354 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator) 02:49:05 INFO - 2015-11-05 02:49:05,958 DEBUG : BROWSER_OUTPUT: RSS: Main: 259944448 02:49:05 INFO - 2015-11-05 02:49:05,958 DEBUG : BROWSER_OUTPUT: 02:49:08 INFO - 2015-11-05 02:49:08,445 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:49:09 INFO - 2015-11-05 02:49:09,035 DEBUG : BROWSER_OUTPUT: RSS: Main: 260509696 02:49:09 INFO - 2015-11-05 02:49:09,035 DEBUG : BROWSER_OUTPUT: 02:49:12 INFO - 2015-11-05 02:49:12,675 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom) 02:49:13 INFO - 2015-11-05 02:49:13,257 DEBUG : BROWSER_OUTPUT: RSS: Main: 258043904 02:49:13 INFO - 2015-11-05 02:49:13,257 DEBUG : BROWSER_OUTPUT: 02:49:17 INFO - 2015-11-05 02:49:17,072 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate) 02:49:17 INFO - 2015-11-05 02:49:17,662 DEBUG : BROWSER_OUTPUT: RSS: Main: 257712128 02:49:17 INFO - 2015-11-05 02:49:17,662 DEBUG : BROWSER_OUTPUT: 02:49:21 INFO - 2015-11-05 02:49:21,144 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial) 02:49:21 INFO - 2015-11-05 02:49:21,740 DEBUG : BROWSER_OUTPUT: RSS: Main: 258412544 02:49:21 INFO - 2015-11-05 02:49:21,741 DEBUG : BROWSER_OUTPUT: 02:49:23 INFO - 2015-11-05 02:49:23,523 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:49:24 INFO - 2015-11-05 02:49:24,102 DEBUG : BROWSER_OUTPUT: RSS: Main: 259784704 02:49:24 INFO - 2015-11-05 02:49:24,102 DEBUG : BROWSER_OUTPUT: 02:49:26 INFO - 2015-11-05 02:49:26,191 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:49:26 INFO - 2015-11-05 02:49:26,822 DEBUG : BROWSER_OUTPUT: RSS: Main: 260554752 02:49:26 INFO - 2015-11-05 02:49:26,822 DEBUG : BROWSER_OUTPUT: 02:49:29 INFO - 2015-11-05 02:49:29,277 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:49:29 INFO - 2015-11-05 02:49:29,867 DEBUG : BROWSER_OUTPUT: RSS: Main: 260263936 02:49:29 INFO - 2015-11-05 02:49:29,867 DEBUG : BROWSER_OUTPUT: 02:49:32 INFO - 2015-11-05 02:49:32,976 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:49:33 INFO - 2015-11-05 02:49:33,580 DEBUG : BROWSER_OUTPUT: RSS: Main: 260112384 02:49:33 INFO - 2015-11-05 02:49:33,580 DEBUG : BROWSER_OUTPUT: 02:49:36 INFO - 2015-11-05 02:49:36,645 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:49:37 INFO - 2015-11-05 02:49:37,237 DEBUG : BROWSER_OUTPUT: RSS: Main: 260792320 02:49:37 INFO - 2015-11-05 02:49:37,237 DEBUG : BROWSER_OUTPUT: 02:49:39 INFO - 2015-11-05 02:49:39,200 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49269/tests/kraken/driver.html?testName=ai-astar) 02:49:39 INFO - 2015-11-05 02:49:39,447 DEBUG : BROWSER_OUTPUT: RSS: Main: 261840896 02:49:39 INFO - 2015-11-05 02:49:39,447 DEBUG : BROWSER_OUTPUT: 02:49:39 INFO - 2015-11-05 02:49:39,447 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:49:39 INFO - 2015-11-05 02:49:39,447 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:49:39 INFO - 2015-11-05 02:49:39,448 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:49:39 INFO - 2015-11-05 02:49:39,448 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:49:39 INFO - 2015-11-05 02:49:39,448 DEBUG : BROWSER_OUTPUT: |0;ai-astar;142;129;142;141;135;141;143;147;148;145 02:49:39 INFO - 2015-11-05 02:49:39,448 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;189;170;190;214;173;196;197;173;212;161 02:49:39 INFO - 2015-11-05 02:49:39,448 DEBUG : BROWSER_OUTPUT: |2;audio-dft;209;208;208;210;211;210;210;212;209;209 02:49:39 INFO - 2015-11-05 02:49:39,448 DEBUG : BROWSER_OUTPUT: |3;audio-fft;88;93;104;150;84;88;90;93;128;87 02:49:39 INFO - 2015-11-05 02:49:39,448 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;108;113;157;111;115;116;155;115;116;169 02:49:39 INFO - 2015-11-05 02:49:39,449 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;151;150;150;157;150;166;156;150;157;157 02:49:39 INFO - 2015-11-05 02:49:39,449 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;164;164;164;163;173;173;166;164;163;165 02:49:39 INFO - 2015-11-05 02:49:39,449 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;140;138;142;143;140;141;145;133;135;140 02:49:39 INFO - 2015-11-05 02:49:39,449 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;70;75;75;78;78;78;79;87;77;78 02:49:39 INFO - 2015-11-05 02:49:39,449 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;80;83;86;87;86;87;88;89;89;90 02:49:39 INFO - 2015-11-05 02:49:39,450 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;107;112;114;115;113;111;113;119;118;118 02:49:39 INFO - 2015-11-05 02:49:39,450 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;168;160;162;170;181;178;182;177;167;171 02:49:39 INFO - 2015-11-05 02:49:39,450 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;192;197;193;194;196;181;197;195;195;185 02:49:39 INFO - 2015-11-05 02:49:39,450 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;82;89;91;90;92;89;90;90;96;99 02:49:39 INFO - 2015-11-05 02:49:39,450 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:49:39 INFO - 2015-11-05 02:49:39,451 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:49:39 INFO - 2015-11-05 02:49:39,451 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,782 02:49:39 INFO - 2015-11-05 02:49:39,451 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:49:39 INFO - 2015-11-05 02:49:39,451 DEBUG : BROWSER_OUTPUT: __startTimestamp1446720579444__endTimestamp 02:49:39 INFO - 2015-11-05 02:49:39,451 DEBUG : BROWSER_OUTPUT: 02:49:39 INFO - 2015-11-05 02:49:39,452 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:49:39 INFO - 2015-11-05 02:49:39,452 DEBUG : BROWSER_OUTPUT: Number of tests: 14 02:49:39 INFO - 2015-11-05 02:49:39,452 DEBUG : BROWSER_OUTPUT: 02:49:39 INFO - 2015-11-05 02:49:39,452 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:141.30 Median:142.50 stddev:5.64 (4.0%) stddev-sans-first:5.97 02:49:39 INFO - 2015-11-05 02:49:39,452 DEBUG : BROWSER_OUTPUT: Values: 142.0 129.0 142.0 141.0 135.0 141.0 143.0 147.0 148.0 145.0 02:49:39 INFO - 2015-11-05 02:49:39,452 DEBUG : BROWSER_OUTPUT: 02:49:39 INFO - 2015-11-05 02:49:39,453 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:187.50 Median:193.00 stddev:17.96 (9.3%) stddev-sans-first:19.04 02:49:39 INFO - 2015-11-05 02:49:39,454 DEBUG : BROWSER_OUTPUT: Values: 189.0 170.0 190.0 214.0 173.0 196.0 197.0 173.0 212.0 161.0 02:49:39 INFO - 2015-11-05 02:49:39,454 DEBUG : BROWSER_OUTPUT: 02:49:39 INFO - 2015-11-05 02:49:39,454 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:209.60 Median:210.00 stddev:1.26 (0.6%) stddev-sans-first:1.32 02:49:39 INFO - 2015-11-05 02:49:39,454 DEBUG : BROWSER_OUTPUT: Values: 209.0 208.0 208.0 210.0 211.0 210.0 210.0 212.0 209.0 209.0 02:49:39 INFO - 2015-11-05 02:49:39,455 DEBUG : BROWSER_OUTPUT: 02:49:39 INFO - 2015-11-05 02:49:39,455 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:100.50 Median:88.00 stddev:21.62 (24.6%) stddev-sans-first:22.46 02:49:39 INFO - 2015-11-05 02:49:39,455 DEBUG : BROWSER_OUTPUT: Values: 88.0 93.0 104.0 150.0 84.0 88.0 90.0 93.0 128.0 87.0 02:49:39 INFO - 2015-11-05 02:49:39,455 DEBUG : BROWSER_OUTPUT: 02:49:39 INFO - 2015-11-05 02:49:39,455 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:127.50 Median:116.00 stddev:23.07 (19.9%) stddev-sans-first:23.36 02:49:39 INFO - 2015-11-05 02:49:39,456 DEBUG : BROWSER_OUTPUT: Values: 108.0 113.0 157.0 111.0 115.0 116.0 155.0 115.0 116.0 169.0 02:49:39 INFO - 2015-11-05 02:49:39,456 DEBUG : BROWSER_OUTPUT: 02:49:39 INFO - 2015-11-05 02:49:39,456 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:154.40 Median:156.50 stddev:5.23 (3.3%) stddev-sans-first:5.40 02:49:39 INFO - 2015-11-05 02:49:39,456 DEBUG : BROWSER_OUTPUT: Values: 151.0 150.0 150.0 157.0 150.0 166.0 156.0 150.0 157.0 157.0 02:49:39 INFO - 2015-11-05 02:49:39,456 DEBUG : BROWSER_OUTPUT: 02:49:39 INFO - 2015-11-05 02:49:39,457 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:165.90 Median:164.50 stddev:3.84 (2.3%) stddev-sans-first:4.01 02:49:39 INFO - 2015-11-05 02:49:39,457 DEBUG : BROWSER_OUTPUT: Values: 164.0 164.0 164.0 163.0 173.0 173.0 166.0 164.0 163.0 165.0 02:49:39 INFO - 2015-11-05 02:49:39,457 DEBUG : BROWSER_OUTPUT: 02:49:39 INFO - 2015-11-05 02:49:39,457 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:139.70 Median:140.50 stddev:3.59 (2.6%) stddev-sans-first:3.81 02:49:39 INFO - 2015-11-05 02:49:39,457 DEBUG : BROWSER_OUTPUT: Values: 140.0 138.0 142.0 143.0 140.0 141.0 145.0 133.0 135.0 140.0 02:49:39 INFO - 2015-11-05 02:49:39,457 DEBUG : BROWSER_OUTPUT: 02:49:39 INFO - 2015-11-05 02:49:39,458 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:77.50 Median:78.00 stddev:4.25 (5.4%) stddev-sans-first:3.54 02:49:39 INFO - 2015-11-05 02:49:39,458 DEBUG : BROWSER_OUTPUT: Values: 70.0 75.0 75.0 78.0 78.0 78.0 79.0 87.0 77.0 78.0 02:49:39 INFO - 2015-11-05 02:49:39,458 DEBUG : BROWSER_OUTPUT: 02:49:39 INFO - 2015-11-05 02:49:39,460 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:86.50 Median:87.50 stddev:3.03 (3.5%) stddev-sans-first:2.11 02:49:39 INFO - 2015-11-05 02:49:39,460 DEBUG : BROWSER_OUTPUT: Values: 80.0 83.0 86.0 87.0 86.0 87.0 88.0 89.0 89.0 90.0 02:49:39 INFO - 2015-11-05 02:49:39,460 DEBUG : BROWSER_OUTPUT: 02:49:39 INFO - 2015-11-05 02:49:39,460 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:114.00 Median:114.50 stddev:3.68 (3.2%) stddev-sans-first:2.91 02:49:39 INFO - 2015-11-05 02:49:39,461 DEBUG : BROWSER_OUTPUT: Values: 107.0 112.0 114.0 115.0 113.0 111.0 113.0 119.0 118.0 118.0 02:49:39 INFO - 2015-11-05 02:49:39,461 DEBUG : BROWSER_OUTPUT: 02:49:39 INFO - 2015-11-05 02:49:39,461 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:171.60 Median:174.00 stddev:7.68 (4.4%) stddev-sans-first:8.03 02:49:39 INFO - 2015-11-05 02:49:39,461 DEBUG : BROWSER_OUTPUT: Values: 168.0 160.0 162.0 170.0 181.0 178.0 182.0 177.0 167.0 171.0 02:49:39 INFO - 2015-11-05 02:49:39,461 DEBUG : BROWSER_OUTPUT: 02:49:39 INFO - 2015-11-05 02:49:39,461 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:192.50 Median:195.00 stddev:5.34 (2.7%) stddev-sans-first:5.66 02:49:39 INFO - 2015-11-05 02:49:39,461 DEBUG : BROWSER_OUTPUT: Values: 192.0 197.0 193.0 194.0 196.0 181.0 197.0 195.0 195.0 185.0 02:49:39 INFO - 2015-11-05 02:49:39,462 DEBUG : BROWSER_OUTPUT: 02:49:39 INFO - 2015-11-05 02:49:39,462 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:90.80 Median:90.50 stddev:4.49 (5.0%) stddev-sans-first:3.46 02:49:39 INFO - 2015-11-05 02:49:39,462 DEBUG : BROWSER_OUTPUT: Values: 82.0 89.0 91.0 90.0 92.0 89.0 90.0 90.0 96.0 99.0 02:49:39 INFO - 2015-11-05 02:49:39,462 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:49:39 INFO - 2015-11-05 02:49:39,462 DEBUG : BROWSER_OUTPUT: 02:49:40 INFO - 2015-11-05 02:49:40,202 INFO : Browser exited with error code: 0 02:49:40 INFO - 2015-11-05 02:49:40,260 INFO : Completed test kraken (00:01:05) 02:49:40 INFO - 2015-11-05 02:49:40,260 INFO : Starting test v8_7 02:49:40 INFO - 2015-11-05 02:49:40,261 DEBUG : operating with platform_type : mac_ 02:49:40 INFO - 2015-11-05 02:49:40,261 INFO : Initialising browser for v8_7 test... 02:49:40 INFO - 2015-11-05 02:49:40,277 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/T/tmpqRNO7S/profile http://localhost:49269/getInfo.html 02:49:43 INFO - 2015-11-05 02:49:43,856 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:49:43 INFO - 2015-11-05 02:49:43,856 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:49:43 INFO - 2015-11-05 02:49:43,857 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 02:49:43 INFO - 2015-11-05 02:49:43,857 DEBUG : BROWSER_OUTPUT: __metrics 02:49:44 INFO - 2015-11-05 02:49:44,579 INFO : Browser initialized. 02:49:44 INFO - 2015-11-05 02:49:44,579 INFO : Running cycle 1/1 for v8_7 test... 02:49:44 INFO - 2015-11-05 02:49:44,579 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/T/tmpqRNO7S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:49:56 INFO - 2015-11-05 02:49:56,799 DEBUG : BROWSER_OUTPUT: RSS: Main: 234131456 02:49:56 INFO - 2015-11-05 02:49:56,799 DEBUG : BROWSER_OUTPUT: 02:50:19 INFO - 2015-11-05 02:50:19,418 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/v8_7/run.html (next: http://localhost:49269/tests/v8_7/run.html) 02:50:19 INFO - 2015-11-05 02:50:19,676 DEBUG : BROWSER_OUTPUT: RSS: Main: 251412480 02:50:19 INFO - 2015-11-05 02:50:19,676 DEBUG : BROWSER_OUTPUT: 02:50:19 INFO - 2015-11-05 02:50:19,676 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:50:19 INFO - 2015-11-05 02:50:19,677 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:50:19 INFO - 2015-11-05 02:50:19,677 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:50:19 INFO - 2015-11-05 02:50:19,677 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:50:19 INFO - 2015-11-05 02:50:19,677 DEBUG : BROWSER_OUTPUT: |0;Richards;206.10057708161582 02:50:19 INFO - 2015-11-05 02:50:19,677 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;247.21878862793574 02:50:19 INFO - 2015-11-05 02:50:19,677 DEBUG : BROWSER_OUTPUT: |2;Encrypt;397.456279809221 02:50:19 INFO - 2015-11-05 02:50:19,677 DEBUG : BROWSER_OUTPUT: |3;Decrypt;7215.827338129497 02:50:19 INFO - 2015-11-05 02:50:19,677 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1420.4545454545455 02:50:19 INFO - 2015-11-05 02:50:19,678 DEBUG : BROWSER_OUTPUT: |5;Earley;971.8172983479105 02:50:19 INFO - 2015-11-05 02:50:19,678 DEBUG : BROWSER_OUTPUT: |6;Boyer;16158.730158730159 02:50:19 INFO - 2015-11-05 02:50:19,678 DEBUG : BROWSER_OUTPUT: |7;RegExp;35807.01754385965 02:50:19 INFO - 2015-11-05 02:50:19,678 DEBUG : BROWSER_OUTPUT: |8;Splay;845.0586264656616 02:50:19 INFO - 2015-11-05 02:50:19,678 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;7070.422535211268 02:50:19 INFO - 2015-11-05 02:50:19,678 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:50:19 INFO - 2015-11-05 02:50:19,679 DEBUG : BROWSER_OUTPUT: __startTimestamp1446720619672__endTimestamp 02:50:19 INFO - 2015-11-05 02:50:19,679 DEBUG : BROWSER_OUTPUT: 02:50:19 INFO - 2015-11-05 02:50:19,679 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:50:19 INFO - 2015-11-05 02:50:19,679 DEBUG : BROWSER_OUTPUT: Number of tests: 10 02:50:19 INFO - 2015-11-05 02:50:19,679 DEBUG : BROWSER_OUTPUT: 02:50:19 INFO - 2015-11-05 02:50:19,679 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:206.10 Median:206.10 stddev:0.00 (0.0%) 02:50:19 INFO - 2015-11-05 02:50:19,679 DEBUG : BROWSER_OUTPUT: Values: 206.1 02:50:19 INFO - 2015-11-05 02:50:19,680 DEBUG : BROWSER_OUTPUT: 02:50:19 INFO - 2015-11-05 02:50:19,680 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:247.22 Median:247.22 stddev:0.00 (0.0%) 02:50:19 INFO - 2015-11-05 02:50:19,680 DEBUG : BROWSER_OUTPUT: Values: 247.2 02:50:19 INFO - 2015-11-05 02:50:19,680 DEBUG : BROWSER_OUTPUT: 02:50:19 INFO - 2015-11-05 02:50:19,680 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:397.46 Median:397.46 stddev:0.00 (0.0%) 02:50:19 INFO - 2015-11-05 02:50:19,680 DEBUG : BROWSER_OUTPUT: Values: 397.5 02:50:19 INFO - 2015-11-05 02:50:19,680 DEBUG : BROWSER_OUTPUT: 02:50:19 INFO - 2015-11-05 02:50:19,680 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:7215.83 Median:7215.83 stddev:0.00 (0.0%) 02:50:19 INFO - 2015-11-05 02:50:19,681 DEBUG : BROWSER_OUTPUT: Values: 7215.8 02:50:19 INFO - 2015-11-05 02:50:19,681 DEBUG : BROWSER_OUTPUT: 02:50:19 INFO - 2015-11-05 02:50:19,681 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1420.45 Median:1420.45 stddev:0.00 (0.0%) 02:50:19 INFO - 2015-11-05 02:50:19,681 DEBUG : BROWSER_OUTPUT: Values: 1420.5 02:50:19 INFO - 2015-11-05 02:50:19,681 DEBUG : BROWSER_OUTPUT: 02:50:19 INFO - 2015-11-05 02:50:19,681 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:971.82 Median:971.82 stddev:0.00 (0.0%) 02:50:19 INFO - 2015-11-05 02:50:19,681 DEBUG : BROWSER_OUTPUT: Values: 971.8 02:50:19 INFO - 2015-11-05 02:50:19,682 DEBUG : BROWSER_OUTPUT: 02:50:19 INFO - 2015-11-05 02:50:19,682 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:16158.73 Median:16158.73 stddev:0.00 (0.0%) 02:50:19 INFO - 2015-11-05 02:50:19,682 DEBUG : BROWSER_OUTPUT: Values: 16158.7 02:50:19 INFO - 2015-11-05 02:50:19,682 DEBUG : BROWSER_OUTPUT: 02:50:19 INFO - 2015-11-05 02:50:19,682 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:35807.02 Median:35807.02 stddev:0.00 (0.0%) 02:50:19 INFO - 2015-11-05 02:50:19,682 DEBUG : BROWSER_OUTPUT: Values: 35807.0 02:50:19 INFO - 2015-11-05 02:50:19,682 DEBUG : BROWSER_OUTPUT: 02:50:19 INFO - 2015-11-05 02:50:19,682 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:845.06 Median:845.06 stddev:0.00 (0.0%) 02:50:19 INFO - 2015-11-05 02:50:19,683 DEBUG : BROWSER_OUTPUT: Values: 845.1 02:50:19 INFO - 2015-11-05 02:50:19,683 DEBUG : BROWSER_OUTPUT: 02:50:19 INFO - 2015-11-05 02:50:19,683 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:7070.42 Median:7070.42 stddev:0.00 (0.0%) 02:50:19 INFO - 2015-11-05 02:50:19,683 DEBUG : BROWSER_OUTPUT: Values: 7070.4 02:50:19 INFO - 2015-11-05 02:50:19,683 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:50:19 INFO - 2015-11-05 02:50:19,683 DEBUG : BROWSER_OUTPUT: 02:50:20 INFO - 2015-11-05 02:50:20,446 INFO : Browser exited with error code: 0 02:50:20 INFO - 2015-11-05 02:50:20,470 INFO : Completed test v8_7 (00:00:40) 02:50:20 INFO - 2015-11-05 02:50:20,634 INFO : Completed test suite (00:20:19) 02:50:20 INFO - 2015-11-05 02:50:20,634 DEBUG : Working with test: dromaeo_css 02:50:20 INFO - 2015-11-05 02:50:20,634 DEBUG : Generating results file: dromaeo_css 02:50:20 INFO - 2015-11-05 02:50:20,635 DEBUG : Working with test: kraken 02:50:20 INFO - 2015-11-05 02:50:20,635 DEBUG : Generating results file: kraken 02:50:20 INFO - 2015-11-05 02:50:20,635 INFO : javascript benchmark 02:50:20 INFO - 2015-11-05 02:50:20,635 DEBUG : Working with test: v8_7 02:50:20 INFO - 2015-11-05 02:50:20,635 DEBUG : Generating results file: v8_7 02:50:20 INFO - 2015-11-05 02:50:20,636 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:50:20 INFO - 2015-11-05 02:50:20,793 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,57]] 02:50:20 INFO - 2015-11-05 02:50:20,793 DEBUG : process_Request line: dromaeo_css 5210.94 graph.html#tests=[[72,64,57]] 02:50:20 INFO - 2015-11-05 02:50:20,793 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:50:20 INFO - 2015-11-05 02:50:20,900 DEBUG : process_Request line: kraken 1959.30 graph.html#tests=[[232,64,57]] 02:50:20 INFO - 2015-11-05 02:50:20,900 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:50:21 INFO - 2015-11-05 02:50:21,016 DEBUG : process_Request line: v8_7 15695.82 graph.html#tests=[[230,64,57]] 02:50:21 INFO - 2015-11-05 02:50:21,017 INFO : javascript benchmark 02:50:21 INFO - 2015-11-05 02:50:21,020 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [270.8496784284722, 272.97543221110095, 273.55001023316635, 276.3864221428429, 276.6762887421715, 10936.234463587552, 13740.450381984721, 14086.943479239073, 14428.639284017892, 14441.927790361047, 9162.633494660222, 9470.38442501237, 9662.082102200297, 14594.343254553543, 15091.62270943227, 3511.315293517765, 3556.430971044633, 3567.6075631680496, 3622.5834029086595, 3635.836387362575, 3496.440569508879, 3511.385507536184, 3525.400681884073, 3592.263585964884, 3602.1534939289245, 2656.734326567347, 2756.6554180727408, 3415.573053368329, 3488.180277634754, 3712.554493460775, 3736.159364143073, 3766.679832214265, 3792.2036372361977, 3829.4064420014943, 3894.6689531389866, 3161.920951976219, 3210.0, 3248.5289633003317, 3248.545203671488, 3251.463508521091, 10261.127804136657, 10621.2034097443, 10666.573337066508, 10667.039966402983, 10823.621173258976, 1367.4256812138926, 1462.5977856089555, 1498.9475368362164, 1538.5076775431867, 1635.1497221444902, 7483.625818709097, 7580.317771400545, 7623.466357354987, 7666.3100320970825, 7894.763157105296, 1228.3121451986915, 1228.9938550307281, 1236.6537369536545, 1251.6557946564676, 1276.7446510697898, 44463.55536444626, 44990.77504612489, 45046.32430513545, 45261.32108018382, 46572.76713616444, 5045.142325804622, 5167.3799144102195, 5174.404943431554, 5202.947970520247, 5208.713520756319, 5909.084091965667, 5953.672548009901, 5978.103284507359, 6047.395260474005, 6056.697165141725, 4151.730137541111, 4241.703080784316, 4245.405643209953, 4265.87202383929, 4315.848945286963, 4443.4445694288215, 4456.799444025027, 4459.598636122764, 4468.776561171929, 4532.524084971096, 2282.44080200352, 2328.0804082387363, 2367.988160059189, 2373.727021392562, 2382.7855493005713, 824.9257566819015, 837.9622916968751, 838.4550042472441, 842.3219308456751, 880.295763389286, 325.71667629539536, 344.2941968963615, 345.623270635009, 349.8128501251818, 370.26871927942636, 7968.681252749825, 8421.073681894986, 8897.644094236159, 8968.192862642394, 9100.31747618918, 362.4617443096999, 371.6283716283716, 374.4233879825093, 379.2642273988454, 379.55402402177884, 4882.292067650242, 4940.950590494121, 5080.822171224063, 5118.923216151761, 5143.099957507421, 341320.0, 411910.0, 420652.0, 421282.0, 427608.0, 58024.12963805546, 58029.4197058024, 58137.0, 58555.0, 58599.0, 399.1398536154592, 403.61051585220406, 404.4297540467926, 405.3575083492697, 410.8295057551083, 8463.280621147025, 8659.00421451516, 8806.779830504032, 8817.823643526965, 9013.414128081653, 27694.0, 28221.294467638472, 28257.0, 29017.0, 29034.564481533216, 33780.15549611279, 35101.0, 35775.0, 36298.0, 37141.0714732123, 4741.336212930123, 4957.652964292609, 4962.8759281018265, 4998.750062496788, 4999.300097986212, 9048.095190480899, 9324.160825525736, 9512.90487095148, 9547.42715437076, 9716.368436051634, 8087.959560202161, 8088.636011379384, 8193.67225310981, 8221.0, 8305.709300174465, 7941.880871786812, 7951.642176102205, 8008.559529225949, 8062.1534738853925, 8077.031777591502, 8104.0, 8271.669133234844, 8285.088640249447, 8389.035260944825, 8551.486910785372, 4872.731999740048, 4903.239997800204, 4917.9016419672125, 4942.5304596063315, 4997.425296090996, 7873.566953817595, 8215.835683286181, 8263.380246481418, 8281.917180828355, 8282.627281772215], "dojo.html": [2537.2515108043126, 2570.5373032854086, 2588.2235329401187, 2597.480503899221, 2650.2579277802224, 4253.106847562008, 4274.059706864488, 4314.805833737481, 4317.373980772786, 4372.081862808814, 4210.6631469482445, 4240.809163587638, 4317.827286908519, 4347.913041739163, 4439.5560443955665, 3915.647591716745, 4045.63589276965, 4054.2904991626497, 4092.1815636872598, 4135.834566617332, 3994.241094192109, 4060.939085913714, 4069.552349241581, 4105.630493255607, 4113.321301985169, 3875.61243875613, 3984.2230765000836, 4005.7796821174825, 4023.3361495353233, 4076.7350122242105, 3834.884953451401, 3923.058465968176, 3958.5447673517624, 4002.079521710023, 4034.515858097018, 3938.7439816411843, 3959.425883246942, 4047.817848196809, 4075.3886916962397, 4094.549599544048, 3998.900027499307, 4182.728122672017, 4198.6641068714425, 4207.894802629929, 4229.851955181584, 4583.404157459542, 4584.816607335736, 4630.86107416778, 4658.930116048262, 4700.012997270577, 4622.884427889296, 4634.165850146972, 4667.6732628716, 4678.274867395559, 4686.039361930796, 4058.2695114879607, 4145.97927010363, 4205.285101532747, 4231.30183519722, 4395.934060989088, 4716.033213191287, 4717.8348757794, 4736.9884231219485, 4786.832460863853, 4801.567858892717, 4518.480374756945, 4536.319552067216, 4553.681242313072, 4590.013147173374, 4654.883627909262, 4259.574042595777, 4506.729596224237, 4532.410786597721, 4590.495045544987, 4613.469451013109, 4541.477730061019, 4591.79336929839, 4612.0, 4614.2617181250835, 4659.091477161921, 4395.604395604411, 4570.4743954445, 4580.610648094949, 4582.885427864263, 4676.859694209179, 3521.9295614087573, 3566.251087271702, 3657.8719744809337, 3674.6876515496483, 3680.2087551176623, 3244.23760416302, 3246.4967929970894, 3282.113829266085, 3283.228441316289, 3303.6861498157637, 4151.12826306473, 4284.485861696617, 4325.632321252729, 4374.868753937387, 4397.362382454527, 4509.481409637868, 4561.347743165919, 4608.446986361658, 4611.0, 4625.121226966866, 4262.360645903139, 4286.764227967429, 4315.223259813264, 4322.330038843984, 4328.329108988112, 3948.5853985331128, 4007.338789099824, 4049.655779258737, 4059.3910913363234, 4074.714769966133, 4641.512641172696, 4644.512326205835, 4650.302454631832, 4671.416072990876, 4785.569298763128, 4616.192166370939, 4634.443866736014, 4695.624350052056, 4725.527447255247, 4734.242521196592, 4440.4227450431235, 4509.413776209072, 4524.683272170916, 4599.448066232074, 4610.608098311681, 4547.590716835369, 4553.79507922151, 4567.885802854955, 4608.884777880446, 4638.83764068256, 4522.005158865044, 4658.720476771405, 4668.0, 4697.13103075932, 4713.457952335525, 4175.958240417557, 4332.935005974849, 4432.445944256968, 4434.889127771831, 4500.9099818004115, 4434.17967675981, 4461.776911154494, 4492.056668099735, 4555.066211426716, 4565.315202719618, 4164.979175104105, 4235.1317979814685, 4423.60187583119, 4446.933296000498, 4456.17560751262, 4314.0, 4403.119376124852, 4425.933610995773, 4438.66709996758, 4440.533743956968, 4407.647388208871, 4427.667924905581, 4432.11357728462, 4487.887802804956, 4495.483019452674], "mootools.html": [1404.3961096728406, 1440.4886265375792, 1444.40779280495, 1447.4210315873652, 1491.746403111471, 5213.3743950725875, 5375.301210842585, 5773.653580785151, 5955.0769630707255, 6112.816615501531, 5576.972115139419, 5666.57500687448, 5736.368999410061, 5742.196092547047, 5879.235699359088, 1730.178165371448, 1732.0300631646319, 1734.9392771253008, 1747.8164792696712, 1767.6729804986055, 1722.6296346285546, 1731.0, 1753.4213709475841, 1759.8680098992563, 1773.219783295346, 1707.436545939843, 1726.2059452651795, 1739.2868923741269, 1749.1254372813594, 1762.5769815244314, 1692.5091723400199, 1694.1190580897864, 1697.7198762204284, 1700.4813531872774, 1716.9313227470886, 1712.049812354143, 1726.6201435684254, 1728.6197036651915, 1747.2224859937332, 1755.4821327708357, 5801.767929282823, 5842.24050873388, 5872.735726892257, 5953.553483488712, 5958.851028724316, 3545.8227088645463, 3622.5834029086463, 3644.2711457708565, 3687.0, 3690.464882592009, 1969.3993332033724, 2048.6722124460166, 2213.645816669325, 2275.84069115162, 2297.6438652008965, 705.5731282574071, 759.5556599389364, 778.6534991928594, 785.9882101768478, 1199.2264989081993, 7324.121105467378, 7352.632368381613, 7367.410607151469, 7443.995060666849, 7507.3243408092985, 3061.7397521210946, 3153.858076386568, 3188.9043328700177, 3203.3112880730755, 3246.62663793662, 6166.383361663798, 6244.000959846494, 6244.469220116341, 6302.401271879256, 6349.0, 3532.717382609385, 3537.7346698997676, 3544.0608238816735, 3607.549056367954, 3609.5668519777796, 3293.720033797106, 3346.0129261867805, 3351.648076951885, 3354.580677415323, 3355.832208389571, 2583.8062145339177, 2599.519088968509, 2625.3174174714713, 2651.350419147321, 2677.170077276012, 779.1818590479974, 786.8741001439743, 788.0543347982444, 789.644659903046, 796.8127490039836, 1029.3000759483623, 1035.2701345551368, 1042.7080417483116, 1046.2310202001522, 1101.5098281264761, 5492.862678433071, 5506.91739623906, 5537.612367134342, 5555.2500412444615, 5677.091665333527, 375.22141556270844, 379.6791711004197, 380.36858814368014, 380.78485655604493, 381.2831876072965, 4410.514843367227, 4470.284754439274, 4480.775961201927, 4491.932621010687, 4555.157295900269, 6222.62664240147, 6245.469135123474, 6582.80251592453, 6727.495437842083, 6852.794416167523, 6555.04951781989, 6633.204015518072, 6671.3328667133865, 6677.833054173684, 6702.865942681216, 5402.594805389612, 5433.782648694087, 5445.37378201504, 5527.060399732055, 5546.55627549795, 5119.46245644202, 5340.919886201787, 5345.732713364238, 5366.7048312343195, 5439.918401224064, 5775.537956963349, 6074.635521868702, 6095.969520152371, 6097.2683278006925, 6186.597871138361, 6112.663803490851, 6121.234845644294, 6122.479589234965, 6129.478994285536, 6173.9073913892225, 5098.97450512745, 5146.202338637517, 5186.9221961669855, 5190.55880250183, 5210.853612205309, 5525.889482210253, 5547.972260138674, 5555.472230138131, 5558.44415558441, 5656.038473459604, 5077.695338279715, 5236.266922630911, 5282.920756188583, 5383.542398895981, 5392.218128371443, 5052.873678158076, 5105.412877519133, 5180.378354597472, 5232.947670523246, 5326.760295786621, 5221.399539052905, 5255.185446255837, 5257.868553286198, 5297.629165958346, 5337.412884582771, 4806.567408933212, 4822.734749588666, 4837.0084132752, 4849.781759820887, 4883.755812209446, 4772.49888761675, 4883.218685010382, 4891.706497610155, 4935.555799978019, 4978.0], "ext.html": [443.9755813430261, 444.8465279478581, 462.4496848749988, 472.76361819090454, 475.67891673120613, 30535.236619084535, 31542.526862097086, 31677.624178186612, 31933.0, 32264.0, 32399.190020249505, 33036.33927321452, 33131.83434082826, 33278.83360583194, 33459.665403345956, 7228.783136505913, 7336.963315183417, 7349.228331025246, 7408.888866667005, 7548.094228692565, 7240.5293655912465, 7300.160481544637, 7310.195878453366, 7342.596157211351, 7377.741779037735, 6741.831454213635, 6744.9325506745045, 6747.898781518281, 6789.01559273905, 6839.1451068616425, 7259.382952449048, 7340.743073992411, 7384.667689953965, 7421.369183619398, 7437.219091995316, 7073.434125269966, 7251.746188883417, 7295.161056478467, 7309.269073092702, 7360.116785985662, 30664.84667576648, 31267.0, 31279.37441251185, 31561.21096972594, 31603.683963160303, 2428.647846062311, 2503.0113105323294, 2551.7065537463245, 2734.753872151516, 2836.858157092158, 21453.67819482709, 21880.23419180321, 22086.11655533793, 22253.554928901493, 23251.0, 1906.3423119023914, 1914.5405102775233, 1926.9132889019888, 1966.4985428715586, 1990.2536548794203, 216308.0, 217126.99999999843, 217421.0, 221051.0, 221538.0, 42297.36553951693, 42488.15023699571, 45207.321890171675, 46037.53962460333, 49581.752091240036, 47869.5213047872, 47899.0, 47979.0, 48394.27408588874, 48955.0, 11577.76844463106, 11663.59177428786, 11768.646940591796, 11947.0, 12019.939900300442, 8902.821943561223, 8913.0, 8913.465192088366, 9052.592633331516, 9072.637094516278, 14543.85456145425, 14793.556193314218, 14886.404543818342, 14916.328765205591, 15117.244137793066, 6266.965950618188, 6433.292337842833, 6465.806025819233, 6541.803745887631, 6542.378474044958, 778.4667502760627, 807.5598798654747, 869.2654706772767, 886.9932626468875, 927.2720914082413, 22557.54884902293, 22618.66072008921, 22635.320940371486, 22672.773272267397, 22956.311310660705, 796.2197046894076, 828.9875651865227, 838.828040251747, 842.4608250719544, 842.5787106446777, 11888.395066666062, 12221.327826969602, 12409.317487538092, 12504.687382815502, 12604.55884044054, 229697.0, 230854.0, 237831.0, 238030.0, 238048.0, 42799.572004280184, 42889.35665965013, 43117.35323970143, 43796.78101609535, 43850.0, 1093.8851420600881, 1124.8987591116838, 1127.7180704823795, 1129.3167633581565, 1133.8129208680475, 22279.10883564639, 22409.32772016842, 22715.0, 22772.4306892329, 23193.0, 36723.44914826226, 37013.62986370102, 37024.07439814026, 37627.81186094052, 37638.0, 227824.0, 230564.0, 233807.0, 234815.0, 235102.0, 23254.534909302056, 33784.0, 34872.30255394827, 35187.296254075285, 35801.64198357983, 36755.0, 36940.44589331109, 37105.44341834821, 37275.0, 37382.62617373792, 30030.699693003666, 31047.223819404695, 31489.37021259516, 31609.52585711262, 31762.205944851565, 29736.0, 30994.84502577563, 31051.534226987063, 31142.844285778425, 31282.68717312798, 31725.5241171378, 31948.36103277875, 32178.356432870743, 32378.67621323851, 33352.14757021576, 25959.351016224744, 26525.469490610467, 27701.30746731348, 27728.722712772615, 27840.721592784623, 20345.6948145775, 20680.276190333265, 21075.8946205268, 21120.894395527925, 21147.577048458636], "prototype.html": [251.26755507695069, 252.3162230355737, 257.94196305831184, 259.1577373536008, 262.1571647154398, 4879.53644403782, 4911.484294149116, 4942.233953737176, 4968.577670897974, 4992.525710057544, 4743.075100355432, 4859.538343857337, 4887.584555312803, 4903.509649035094, 4976.751162441881, 3735.477033215352, 3739.1773809761876, 3748.8125593720342, 3750.2124553843723, 3802.6007269236748, 3703.7962912039825, 3732.7387082904206, 3781.4327850822324, 3809.771413715172, 3811.866584669537, 3691.243295124493, 3697.870574529892, 3713.758605690635, 3726.273376691546, 3759.9436008459893, 3607.116256517157, 3678.3746763050344, 3693.353663108945, 3712.2389910068373, 3777.773333599979, 3127.6559578446354, 3160.083575763026, 3188.4420226460275, 3192.632847222576, 3224.2100685332243, 4723.244280915072, 4733.124371991193, 4735.360726301939, 4858.052679727454, 4866.78099485524, 4159.500859896832, 4159.667226621863, 4163.5628259032665, 4246.6602671786495, 4270.850520231808, 4950.331705219821, 4951.801927922878, 4984.22744474607, 5149.845504634867, 5255.500727430888, 3386.136535183537, 3400.96599034009, 3401.557797486336, 3407.2333724911946, 3454.844531996066, 5358.196270559409, 5358.973205133989, 5373.194020896896, 5446.945530544723, 5453.454654534515, 3453.223024819446, 3468.722502199818, 3472.6700963408434, 3478.060923550627, 3544.220271540257, 3475.860965561349, 3532.1875968527384, 3539.7876127432437, 3569.196930690626, 3596.6583174598372, 3949.92100158001, 3971.3447281198855, 4107.034846810997, 4136.193442278727, 4223.619874211336, 5084.059449001947, 5087.16061849798, 5108.489151084936, 5158.174692049254, 5204.739763011834, 1259.7921342978307, 1286.9613911582667, 1289.9806502902463, 1299.3048718935324, 1305.3016636099642, 813.6704634622869, 826.6486743134144, 830.8172202115525, 834.1241696218946, 845.5222799118478, 4965.726885021286, 4967.82612608557, 4997.3253610762085, 5078.0, 5080.212567052113, 5400.378956419983, 5413.458654134555, 5474.616776825664, 5476.780928762884, 5524.392316845144, 4949.455559888409, 4983.9252411213865, 5021.949780502148, 5033.6224783141415, 5049.520295571915, 2878.266042159236, 2946.528555431121, 2994.0419065898705, 3007.6090108285784, 3053.0382929377174, 5430.5384042356845, 5484.122540393518, 5521.033819081645, 5543.0, 5553.694546799965, 5537.612367134342, 5574.916376254359, 5619.522340601013, 5644.6613203207935, 5656.745446454919, 5448.101063324507, 5534.612577119563, 5541.750621221974, 5543.307086614173, 5558.805441809517, 5254.290670759551, 5409.945900540944, 5422.213779001943, 5492.176173573996, 5507.531859791802, 5346.8395948121615, 5347.0375332440535, 5376.274202982548, 5381.2197231402015, 5387.784488620411, 5444.6188766785945, 5529.060059789926, 5534.723263836711, 5549.5837812163445, 5561.026820306511, 3552.5381700378784, 3571.6964058055355, 3586.870135907181, 3591.048372181426, 3596.6583174598372, 5184.974075129751, 5284.128118860345, 5374.355077390738, 5432.130859062531, 5490.231367608458, 5087.287779710918, 5133.717645529532, 5144.871378215575, 5239.371275446971, 5243.606729495379, 5180.300659410931, 5205.06308864408, 5211.687298762086, 5231.738413079407, 5259.47405259471, 5045.419776725576, 5151.072806894795, 5154.61340399479, 5168.457311982338, 5178.223266510054, 4990.50094990498, 5179.637425380338, 5285.075111855333, 5287.154055351125, 5391.353037635509, 5121.283020377075, 5173.042987047408, 5180.119379705384, 5241.030409374278, 5256.132738098171], "yui.html": [579.3771695427416, 584.9122631605259, 613.4908026338138, 624.4068135271492, 629.5844742469965, 10956.5617375305, 12489.750204995906, 12565.057620678463, 12608.180468269557, 12968.675783105427, 11522.0, 11542.711432214199, 11661.70845728855, 11696.824547631792, 11746.471408786603, 546.4890327543759, 556.7578103524979, 691.2223748283182, 692.6536731634183, 718.5509056839476, 682.8600136971909, 690.5131882023162, 695.5131408014411, 699.1435491522894, 705.9858802823941, 725.989110163348, 726.1177669132004, 726.920038795732, 732.9560226386408, 737.5390381011867, 664.8271449423137, 709.6026225313789, 714.878470659989, 716.5306724095726, 723.7141329174973, 517.3920643244173, 522.9843104706865, 525.7134861500491, 527.2565682387853, 528.7488442989587, 10560.26078174528, 10591.364518128938, 10611.734706632318, 10771.299865508796, 10790.67627971162, 7541.283578060075, 7657.540547567108, 7759.816157533937, 7869.370450363957, 8091.878621820678, 7109.6445177741425, 7136.143662760502, 7217.458690598226, 7279.012148337602, 7609.010828592303, 2261.869362672214, 2396.1733202045266, 2419.2621250518587, 2467.938301542476, 2477.3930387055107, 36281.81859090714, 36387.4541881872, 36470.8176459116, 36598.8170059148, 36935.261294773954, 4968.503149685002, 5028.421731500925, 5054.292399064134, 5138.946515964219, 5276.5251127398715, 9074.092590741006, 9508.572114254875, 9540.14138727504, 9541.332106752461, 9552.761180970392, 4800.783964721596, 4826.806927722922, 5010.123228435083, 5063.316452278968, 5075.467075956972, 3036.4686179918426, 3099.5195744659613, 3150.6691797361404, 3257.990023092849, 3353.094664440587, 2097.517570958688, 2123.373604786592, 2125.6811478278382, 2137.10241698487, 2144.249512670584, 312.4189008444292, 313.56414583728633, 322.7659946538741, 324.79375596496396, 330.6049271120987, 425.3768229543671, 473.1908436573498, 479.26911460023047, 483.97638993529137, 490.9484504127015, 6345.460635846005, 6491.0, 6491.415772580491, 7014.473914456335, 7113.288671132948, 386.4454507781343, 476.9356136921471, 478.818049141331, 488.2919766338823, 489.70617629422776, 3004.4892368297005, 3039.937805862602, 3163.4463968805367, 3167.7149056585017, 3202.343519578481, 48041.0, 48137.0, 48709.26936095962, 48828.755856220494, 49186.0, 36567.26865462676, 37578.06054848596, 40516.797416012734, 41464.58535414668, 41724.1655166895, 38896.0, 39505.60494395077, 40353.99115022089, 40375.39436908449, 41184.79407602943, 6712.496562757715, 6758.93241067583, 6815.0, 6863.691133899087, 6940.861182776417, 27302.269773022537, 27801.887924483603, 27924.58113128264, 28104.71895281103, 28344.433111337246, 32531.34937301288, 36599.63400365962, 36671.81664091662, 37079.443808343436, 37209.069773255884, 8583.18459746323, 8598.33750865355, 8600.268977136762, 8692.739217823475, 8695.173958473935, 8669.476219145103, 8825.779355516164, 8928.464292142493, 8968.327375446737, 9101.499417532099, 8468.195521425454, 8514.276286515715, 8524.062353141273, 8670.13298670128, 8764.21122099014, 8329.95835020821, 8480.406371553932, 8564.871526926976, 8577.386170586995, 8598.656053757779, 8137.267645911897, 8315.126911674188, 8467.61895714682, 8472.788180295542, 8552.102029287083, 7060.505764596429, 7228.855422891618, 7372.594507301936, 7410.407167426485, 7467.663955121924, 6577.0, 6925.134358205224, 6990.335918087773, 7303.8539229216185, 7453.0]}, "summary": {"suite": 5210.94524017267, "subtests": {"jquery.html": {"filtered": 5250.724957781153, "value": 5250.724957781153}, "dojo.html": {"filtered": 4253.695916009922, "value": 4253.695916009922}, "mootools.html": {"filtered": 3302.51372007328, "value": 3302.51372007328}, "ext.html": {"filtered": 14847.094178069881, "value": 14847.094178069881}, "prototype.html": {"filtered": 3881.1916704582422, "value": 3881.1916704582422}, "yui.html": {"filtered": 4709.909521392241, "value": 4709.909521392241}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0083.e"}, "testrun": {"date": 1446719401, "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": "20151105005737", "branch": "Fx-Team", "revision": "c951580b6f9b81f7dcab62b40d03ad96d666e1ca"}}, {"talos_counters": {}, "results": {"audio-dft": [209.0, 208.0, 208.0, 210.0, 211.0, 210.0, 210.0, 212.0, 209.0, 209.0], "ai-astar": [142.0, 129.0, 142.0, 141.0, 135.0, 141.0, 143.0, 147.0, 148.0, 145.0], "imaging-gaussian-blur": [151.0, 150.0, 150.0, 157.0, 150.0, 166.0, 156.0, 150.0, 157.0, 157.0], "audio-beat-detection": [189.0, 170.0, 190.0, 214.0, 173.0, 196.0, 197.0, 173.0, 212.0, 161.0], "json-stringify-tinderbox": [80.0, 83.0, 86.0, 87.0, 86.0, 87.0, 88.0, 89.0, 89.0, 90.0], "stanford-crypto-pbkdf2": [192.0, 197.0, 193.0, 194.0, 196.0, 181.0, 197.0, 195.0, 195.0, 185.0], "json-parse-financial": [70.0, 75.0, 75.0, 78.0, 78.0, 78.0, 79.0, 87.0, 77.0, 78.0], "stanford-crypto-sha256-iterative": [82.0, 89.0, 91.0, 90.0, 92.0, 89.0, 90.0, 90.0, 96.0, 99.0], "audio-fft": [88.0, 93.0, 104.0, 150.0, 84.0, 88.0, 90.0, 93.0, 128.0, 87.0], "imaging-darkroom": [164.0, 164.0, 164.0, 163.0, 173.0, 173.0, 166.0, 164.0, 163.0, 165.0], "stanford-crypto-ccm": [168.0, 160.0, 162.0, 170.0, 181.0, 178.0, 182.0, 177.0, 167.0, 171.0], "audio-oscillator": [108.0, 113.0, 157.0, 111.0, 115.0, 116.0, 155.0, 115.0, 116.0, 169.0], "stanford-crypto-aes": [107.0, 112.0, 114.0, 115.0, 113.0, 111.0, 113.0, 119.0, 118.0, 118.0], "imaging-desaturate": [140.0, 138.0, 142.0, 143.0, 140.0, 141.0, 145.0, 133.0, 135.0, 140.0]}, "summary": {"suite": 1959.3, "subtests": {"audio-fft": {"filtered": 100.5, "value": 100.5}, "stanford-crypto-pbkdf2": {"filtered": 192.5, "value": 192.5}, "audio-beat-detection": {"filtered": 187.5, "value": 187.5}, "stanford-crypto-ccm": {"filtered": 171.6, "value": 171.6}, "imaging-darkroom": {"filtered": 165.9, "value": 165.9}, "json-parse-financial": {"filtered": 77.5, "value": 77.5}, "audio-oscillator": {"filtered": 127.5, "value": 127.5}, "ai-astar": {"filtered": 141.3, "value": 141.3}, "audio-dft": {"filtered": 209.6, "value": 209.6}, "stanford-crypto-sha256-iterative": {"filtered": 90.8, "value": 90.8}, "json-stringify-tinderbox": {"filtered": 86.5, "value": 86.5}, "imaging-gaussian-blur": {"filtered": 154.4, "value": 154.4}, "stanford-crypto-aes": {"filtered": 114.0, "value": 114.0}, "imaging-desaturate": {"filtered": 139.7, "value": 139.7}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0083.e"}, "testrun": {"date": 1446719401, "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": "20151105005737", "branch": "Fx-Team", "revision": "c951580b6f9b81f7dcab62b40d03ad96d666e1ca"}}, {"talos_counters": {}, "results": {"DeltaBlue": [247.21878862793574], "Encrypt": [397.456279809221], "NavierStokes": [7070.422535211268], "Decrypt": [7215.827338129497], "Splay": [845.0586264656616], "Richards": [206.10057708161582], "RegExp": [35807.01754385965], "Earley": [971.8172983479105], "Boyer": [16158.730158730159], "RayTrace": [1420.4545454545455]}, "summary": {"suite": 15695.816016016195, "subtests": {"DeltaBlue": {"filtered": 267.4473099999999, "value": 267.4473099999999}, "Encrypt": {"filtered": 669.7113960000003, "value": 669.7113960000003}, "NavierStokes": {"filtered": 209.8884462151396, "value": 209.8884462151396}, "Decrypt": {"filtered": 36.88849351944168, "value": 36.88849351944168}, "Splay": {"filtered": 96.43236273538153, "value": 96.43236273538153}, "RegExp": {"filtered": 25.441521313081843, "value": 25.441521313081843}, "Richards": {"filtered": 171.28530400000002, "value": 171.28530400000002}, "Earley": {"filtered": 685.7904269999998, "value": 685.7904269999998}, "Boyer": {"filtered": 41.24476326129666, "value": 41.24476326129666}, "RayTrace": {"filtered": 520.9522559999998, "value": 520.9522559999998}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0083.e"}, "testrun": {"date": 1446719401, "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": "20151105005737", "branch": "Fx-Team", "revision": "c951580b6f9b81f7dcab62b40d03ad96d666e1ca"}}] 02:50:21 INFO - RETURN: dromaeo_css: 5210.94 02:50:21 INFO - RETURN: kraken: 1959.30 02:50:21 INFO - RETURN: v8_7: 15695.82 02:50:21 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,57]]", "result": "15695.82"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,57]]", "result": "1959.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,57]]", "result": "5210.94"}}} 02:50:21 INFO - Return code: 0 02:50:21 INFO - # TBPL SUCCESS # 02:50:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:50:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:50:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:50:21 INFO - 2015-11-05 02:50:21.157 screenresolution[1660:10470] starting screenresolution argv=screenresolution get 02:50:21 INFO - 2015-11-05 02:50:21.160 screenresolution[1660:10470] Display 0: 1600x1200x32@60 02:50:21 INFO - 2015-11-05 02:50:21.167 screenresolution[1661:10473] starting screenresolution argv=screenresolution list 02:50:21 INFO - Available Modes on Display 0 02:50:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:50:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:50:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:50:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:50:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:50:21 INFO - Intel HD Graphics 3000: 02:50:21 INFO - Chipset Model: Intel HD Graphics 3000 02:50:21 INFO - Type: GPU 02:50:21 INFO - Bus: Built-In 02:50:21 INFO - VRAM (Total): 512 MB 02:50:21 INFO - VRAM (Dynamic, Max): 10 02:50:21 INFO - Vendor: Intel (0x8086) 02:50:21 INFO - Device ID: 0x0116 02:50:21 INFO - Revision ID: 0x0009 02:50:21 INFO - Displays: 02:50:21 INFO - Display: 02:50:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:50:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:50:21 INFO - Display Serial Number: 1600x1200 60 02:50:21 INFO - Main Display: Yes 02:50:21 INFO - Mirror: Off 02:50:21 INFO - Online: Yes 02:50:21 INFO - Rotation: Supported 02:50:21 INFO - Return code: 0 02:50:21 INFO - Running post-action listener: _resource_record_post_action 02:50:21 INFO - Running post-run listener: _resource_record_post_run 02:50:22 INFO - Total resource usage - Wall time: 1266s; CPU: 30.0%; Read bytes: 39621632; Write bytes: 688966656; Read time: 7924; Write time: 109731 02:50:22 INFO - install - Wall time: 45s; CPU: 30.0%; Read bytes: 343003648; Write bytes: 346431488; Read time: 40383; Write time: 43953 02:50:22 INFO - run-tests - Wall time: 1221s; CPU: 30.0%; Read bytes: 37291008; Write bytes: 341322752; Read time: 6480; Write time: 65757 02:50:22 INFO - Running post-run listener: _upload_blobber_files 02:50:22 INFO - Blob upload gear active. 02:50:22 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 02:50:22 INFO - Copying logs to upload dir... 02:50:22 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1344.567725 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 24 secs) (at 2015-11-05 02:50:22.638165) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-05 02:50:22.643354) ========= 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.cW8ohHWoYx/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.U9WpRmfQiY/Listeners TMPDIR=/var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/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/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010272 build_url: 'https://queue.taskcluster.net/v1/task/2tgUgpuGRBOiUGDWH0Lrnw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-05 02:50:22.674700) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 02:50:22.675101) ========= 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.cW8ohHWoYx/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.U9WpRmfQiY/Listeners TMPDIR=/var/folders/kp/j5x6235d3dx58ghkpy3ymrt800000w/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.005773 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 02:50:22.726513) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-05 02:50:22.726941) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-05 02:50:22.727874) ========= ========= Total master_lag: 0.50 =========