builder: fx-team_yosemite_test-dromaeojs slave: t-yosemite-r5-0052 starttime: 1446839174.09 results: success (0) buildid: 20151105001636 builduid: 8354ded0d0e54afe85f80e2b720e3b09 revision: ff8ebe5251ec227be26994089871cb40c1da3011 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-06 11:46:14.093108) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-06 11:46:14.093571) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-06 11:46:14.093901) ========= 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.tEu47zSKc1/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.4ldzly0Q3v/Listeners TMPDIR=/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/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.006415 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-06 11:46:14.121530) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-06 11:46:14.121885) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-06 11:46:14.151238) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2015-11-06 11:46:14.151608) ========= 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.tEu47zSKc1/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.4ldzly0Q3v/Listeners TMPDIR=/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/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.005460 ========= master_lag: 3.53 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2015-11-06 11:46:17.686429) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-06 11:46:17.686868) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-06 11:46:17.687344) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-06 11:46:17.687658) ========= 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.tEu47zSKc1/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.4ldzly0Q3v/Listeners TMPDIR=/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/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-06 11:46:17-- 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% 11.2M=0.001s 2015-11-06 11:46:17 (11.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.193717 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-06 11:46:17.899708) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-06 11:46:17.900067) ========= 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.tEu47zSKc1/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.4ldzly0Q3v/Listeners TMPDIR=/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/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.020778 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-06 11:46:17.951704) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-06 11:46:17.952127) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ff8ebe5251ec227be26994089871cb40c1da3011 --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 ff8ebe5251ec227be26994089871cb40c1da3011 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tEu47zSKc1/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.4ldzly0Q3v/Listeners TMPDIR=/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/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-06 11:46:18,032 truncating revision to first 12 chars 2015-11-06 11:46:18,032 Setting DEBUG logging. 2015-11-06 11:46:18,033 attempt 1/10 2015-11-06 11:46:18,033 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ff8ebe5251ec?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-06 11:46:18,331 unpacking tar archive at: fx-team-ff8ebe5251ec/testing/mozharness/ program finished with exit code 0 elapsedTime=0.712332 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-06 11:46:18.681953) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-06 11:46:18.682339) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-06 11:46:18.696053) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-06 11:46:18.696412) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-06 11:46:18.696882) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 6 secs) (at 2015-11-06 11:46:18.697227) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.tEu47zSKc1/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.4ldzly0Q3v/Listeners TMPDIR=/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/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 11:46:18 INFO - MultiFileLogger online at 20151106 11:46:18 in /builds/slave/test 11:46:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 11:46:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:46:18 INFO - {'append_to_log': False, 11:46:18 INFO - 'base_work_dir': '/builds/slave/test', 11:46:18 INFO - 'blob_upload_branch': 'Fx-Team', 11:46:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:46:18 INFO - 'branch': 'Fx-Team', 11:46:18 INFO - 'buildbot_json_path': 'buildprops.json', 11:46:18 INFO - 'config_files': ('talos/mac_config.py',), 11:46:18 INFO - 'default_actions': ('clobber', 11:46:18 INFO - 'read-buildbot-config', 11:46:18 INFO - 'download-and-extract', 11:46:18 INFO - 'populate-webroot', 11:46:18 INFO - 'create-virtualenv', 11:46:18 INFO - 'install', 11:46:18 INFO - 'run-tests'), 11:46:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:46:18 INFO - 'download_minidump_stackwalk': True, 11:46:18 INFO - 'download_symbols': 'ondemand', 11:46:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:46:18 INFO - 'tooltool.py': '/tools/tooltool.py', 11:46:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:46:18 INFO - '/tools/misc-python/virtualenv.py')}, 11:46:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:46:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:46:18 INFO - 'installer_path': 'installer.exe', 11:46:18 INFO - 'log_level': 'info', 11:46:18 INFO - 'log_name': 'talos', 11:46:18 INFO - 'log_to_console': True, 11:46:18 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:46:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:46:18 INFO - 'opt_config_files': (), 11:46:18 INFO - 'pip_index': False, 11:46:18 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:46:18 INFO - 'cmd': ('bash', 11:46:18 INFO - '-c', 11:46:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:46:18 INFO - 'enabled': True, 11:46:18 INFO - 'halt_on_failure': False, 11:46:18 INFO - 'name': 'check_screen_resolution'},), 11:46:18 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:46:18 INFO - 'cmd': ('bash', 11:46:18 INFO - '-c', 11:46:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:46:18 INFO - 'enabled': True, 11:46:18 INFO - 'halt_on_failure': False, 11:46:18 INFO - 'name': 'check_screen_resolution'},), 11:46:18 INFO - 'run_cmd_checks_enabled': True, 11:46:18 INFO - 'sps_profile': False, 11:46:18 INFO - 'sps_profile_interval': 0, 11:46:18 INFO - 'suite': 'dromaeojs', 11:46:18 INFO - 'system_bits': '64', 11:46:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:46:18 INFO - 'title': 't-yosemite-r5-0052', 11:46:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:46:18 INFO - 'use_talos_json': True, 11:46:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:46:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:46:18 INFO - 'work_dir': 'build'} 11:46:18 INFO - ##### 11:46:18 INFO - ##### Running clobber step. 11:46:18 INFO - ##### 11:46:18 INFO - Running pre-action listener: _resource_record_pre_action 11:46:18 INFO - Running main action method: clobber 11:46:18 INFO - rmtree: /builds/slave/test/build 11:46:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:46:20 INFO - Running post-action listener: _resource_record_post_action 11:46:20 INFO - ##### 11:46:20 INFO - ##### Running read-buildbot-config step. 11:46:20 INFO - ##### 11:46:20 INFO - Running pre-action listener: _resource_record_pre_action 11:46:20 INFO - Running main action method: read_buildbot_config 11:46:20 INFO - Using buildbot properties: 11:46:20 INFO - { 11:46:20 INFO - "properties": { 11:46:20 INFO - "buildnumber": 1313, 11:46:20 INFO - "product": "firefox", 11:46:20 INFO - "script_repo_revision": "production", 11:46:20 INFO - "builddir": "fx-team_yosemite_test-dromaeojs", 11:46:20 INFO - "repository": "", 11:46:20 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 fx-team talos dromaeojs", 11:46:20 INFO - "buildid": "20151105001636", 11:46:20 INFO - "slavename": "t-yosemite-r5-0052", 11:46:20 INFO - "pgo_build": "False", 11:46:20 INFO - "basedir": "/builds/slave/test", 11:46:20 INFO - "project": "", 11:46:20 INFO - "platform": "yosemite", 11:46:20 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 11:46:20 INFO - "slavebuilddir": "test", 11:46:20 INFO - "scheduler": "tests-fx-team-macosx64-talos", 11:46:20 INFO - "branch": "fx-team", 11:46:20 INFO - "repo_path": "integration/fx-team", 11:46:20 INFO - "stage_platform": "macosx64", 11:46:20 INFO - "builduid": "8354ded0d0e54afe85f80e2b720e3b09", 11:46:20 INFO - "revision": "ff8ebe5251ec227be26994089871cb40c1da3011" 11:46:20 INFO - }, 11:46:20 INFO - "sourcestamp": { 11:46:20 INFO - "repository": "", 11:46:20 INFO - "hasPatch": false, 11:46:20 INFO - "project": "", 11:46:20 INFO - "branch": "fx-team-macosx64-talos", 11:46:20 INFO - "changes": [ 11:46:20 INFO - { 11:46:20 INFO - "category": null, 11:46:20 INFO - "files": [ 11:46:20 INFO - { 11:46:20 INFO - "url": null, 11:46:20 INFO - "name": "https://queue.taskcluster.net/v1/task/2LkZYG3HTmaPgd6O0Zsr7g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 11:46:20 INFO - } 11:46:20 INFO - ], 11:46:20 INFO - "repository": "", 11:46:20 INFO - "rev": "ff8ebe5251ec227be26994089871cb40c1da3011", 11:46:20 INFO - "who": "jryans@gmail.com", 11:46:20 INFO - "when": 1446718642, 11:46:20 INFO - "number": 6624242, 11:46:20 INFO - "comments": "Bug 1182722 - Add quotes for l10n-check on Windows. rs=glandium on a CLOSED TREE\n", 11:46:20 INFO - "project": "", 11:46:20 INFO - "at": "Thu 05 Nov 2015 02:17:22", 11:46:20 INFO - "branch": "fx-team-macosx64-talos", 11:46:20 INFO - "revlink": "", 11:46:20 INFO - "properties": [ 11:46:20 INFO - [ 11:46:20 INFO - "buildid", 11:46:20 INFO - "20151105001636", 11:46:20 INFO - "Change" 11:46:20 INFO - ], 11:46:20 INFO - [ 11:46:20 INFO - "builduid", 11:46:20 INFO - "8354ded0d0e54afe85f80e2b720e3b09", 11:46:20 INFO - "Change" 11:46:20 INFO - ], 11:46:20 INFO - [ 11:46:20 INFO - "pgo_build", 11:46:20 INFO - "False", 11:46:20 INFO - "Change" 11:46:20 INFO - ] 11:46:20 INFO - ], 11:46:20 INFO - "revision": "ff8ebe5251ec227be26994089871cb40c1da3011" 11:46:20 INFO - } 11:46:20 INFO - ], 11:46:20 INFO - "revision": "ff8ebe5251ec227be26994089871cb40c1da3011" 11:46:20 INFO - } 11:46:20 INFO - } 11:46:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/2LkZYG3HTmaPgd6O0Zsr7g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 11:46:20 INFO - Running post-action listener: _resource_record_post_action 11:46:20 INFO - ##### 11:46:20 INFO - ##### Running download-and-extract step. 11:46:20 INFO - ##### 11:46:20 INFO - Running pre-action listener: _resource_record_pre_action 11:46:20 INFO - Running main action method: download_and_extract 11:46:20 INFO - mkdir: /builds/slave/test/build/tests 11:46:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:46:20 INFO - https://queue.taskcluster.net/v1/task/2LkZYG3HTmaPgd6O0Zsr7g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:46:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2LkZYG3HTmaPgd6O0Zsr7g/artifacts/public/build/test_packages.json 11:46:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2LkZYG3HTmaPgd6O0Zsr7g/artifacts/public/build/test_packages.json 11:46:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2LkZYG3HTmaPgd6O0Zsr7g/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 11:46:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2LkZYG3HTmaPgd6O0Zsr7g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 11:46:21 INFO - Downloaded 1149 bytes. 11:46:21 INFO - Reading from file /builds/slave/test/build/test_packages.json 11:46:21 INFO - Using the following test package requirements: 11:46:21 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 11:46:21 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:46:21 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 11:46:21 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:46:21 INFO - u'jsshell-mac.zip'], 11:46:21 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:46:21 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 11:46:21 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 11:46:21 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:46:21 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 11:46:21 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:46:21 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 11:46:21 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:46:21 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 11:46:21 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 11:46:21 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:46:21 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 11:46:21 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:46:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:46:21 INFO - https://queue.taskcluster.net/v1/task/2LkZYG3HTmaPgd6O0Zsr7g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:46:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2LkZYG3HTmaPgd6O0Zsr7g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:46:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2LkZYG3HTmaPgd6O0Zsr7g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:46:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2LkZYG3HTmaPgd6O0Zsr7g/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 11:46:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2LkZYG3HTmaPgd6O0Zsr7g/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 11:46:22 INFO - Downloaded 17457315 bytes. 11:46:22 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 11:46:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:46:22 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 11:46:27 INFO - Return code: 0 11:46:27 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 11:46:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:46:27 INFO - https://queue.taskcluster.net/v1/task/2LkZYG3HTmaPgd6O0Zsr7g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:46:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2LkZYG3HTmaPgd6O0Zsr7g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:46:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2LkZYG3HTmaPgd6O0Zsr7g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:46:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2LkZYG3HTmaPgd6O0Zsr7g/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 11:46:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2LkZYG3HTmaPgd6O0Zsr7g/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 11:46:28 INFO - Downloaded 17457315 bytes. 11:46:28 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 11:46:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:46:28 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 11:46:34 INFO - Return code: 0 11:46:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:46:34 INFO - https://queue.taskcluster.net/v1/task/2LkZYG3HTmaPgd6O0Zsr7g/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 11:46:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2LkZYG3HTmaPgd6O0Zsr7g/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 11:46:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2LkZYG3HTmaPgd6O0Zsr7g/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 11:46:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2LkZYG3HTmaPgd6O0Zsr7g/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 11:46:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2LkZYG3HTmaPgd6O0Zsr7g/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 11:46:35 INFO - Downloaded 11131307 bytes. 11:46:35 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 11:46:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 11:46:35 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 11:46:36 INFO - Return code: 0 11:46:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:46:36 INFO - https://queue.taskcluster.net/v1/task/2LkZYG3HTmaPgd6O0Zsr7g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 11:46:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2LkZYG3HTmaPgd6O0Zsr7g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 11:46:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2LkZYG3HTmaPgd6O0Zsr7g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 11:46:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2LkZYG3HTmaPgd6O0Zsr7g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 11:46:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2LkZYG3HTmaPgd6O0Zsr7g/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 11:46:48 INFO - Downloaded 108653318 bytes. 11:46:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/2LkZYG3HTmaPgd6O0Zsr7g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 11:46:48 INFO - mkdir: /builds/slave/test/properties 11:46:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:46:48 INFO - Writing to file /builds/slave/test/properties/build_url 11:46:48 INFO - Contents: 11:46:48 INFO - build_url:https://queue.taskcluster.net/v1/task/2LkZYG3HTmaPgd6O0Zsr7g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 11:46:48 INFO - Running post-action listener: _resource_record_post_action 11:46:48 INFO - Running post-action listener: set_extra_try_arguments 11:46:48 INFO - ##### 11:46:48 INFO - ##### Running populate-webroot step. 11:46:48 INFO - ##### 11:46:48 INFO - Running pre-action listener: _resource_record_pre_action 11:46:48 INFO - Running main action method: populate_webroot 11:46:48 INFO - Guessing talos json url... 11:46:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:46:48 INFO - https://queue.taskcluster.net/v1/task/2LkZYG3HTmaPgd6O0Zsr7g/artifacts/public/build/firefox-45.0a1.en-US.mac.txt matches https://queue.taskcluster.net 11:46:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2LkZYG3HTmaPgd6O0Zsr7g/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 11:46:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2LkZYG3HTmaPgd6O0Zsr7g/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 11:46:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2LkZYG3HTmaPgd6O0Zsr7g/artifacts/public/build/firefox-45.0a1.en-US.mac.txt to /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 11:46:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2LkZYG3HTmaPgd6O0Zsr7g/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 11:46:49 INFO - Downloaded 103 bytes. 11:46:49 INFO - Reading from file /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 11:46:49 INFO - Contents: 11:46:49 INFO - 20151105001636 11:46:49 INFO - https://hg.mozilla.org/integration/fx-team/rev/ff8ebe5251ec227be26994089871cb40c1da3011 11:46:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:46:49 INFO - trying https://hg.mozilla.org/integration/fx-team/raw-file/ff8ebe5251/testing/talos/talos.json 11:46:49 INFO - Downloading https://hg.mozilla.org/integration/fx-team/raw-file/ff8ebe5251/testing/talos/talos.json to /builds/slave/test/build/talos.json 11:46:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/integration/fx-team/raw-file/ff8ebe5251/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 11:46:49 INFO - Downloaded 4264 bytes. 11:46:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:46:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:46:49 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 11:46:49 INFO - '../fennec_ids.txt'], 11:46:49 INFO - 'tests': ['tcheck2']}, 11:46:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:46:49 INFO - '--tppagecycles', 11:46:49 INFO - '7'], 11:46:49 INFO - 'tests': ['tsvgm']}}, 11:46:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:46:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:46:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:46:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:46:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:46:49 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:46:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:46:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:46:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:46:49 INFO - 'talos_options': ['--e10s'], 11:46:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:46:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:46:49 INFO - 'tests': ['damp', 'tps']}, 11:46:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:46:49 INFO - 'talos_options': ['--e10s'], 11:46:49 INFO - 'tests': ['damp', 'tps']}, 11:46:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:46:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:46:49 INFO - 'other': {'tests': ['a11yr', 11:46:49 INFO - 'ts_paint', 11:46:49 INFO - 'tpaint', 11:46:49 INFO - 'sessionrestore', 11:46:49 INFO - 'sessionrestore_no_auto_restore']}, 11:46:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:46:49 INFO - 'tests': ['a11yr', 11:46:49 INFO - 'ts_paint', 11:46:49 INFO - 'tpaint', 11:46:49 INFO - 'sessionrestore', 11:46:49 INFO - 'sessionrestore_no_auto_restore']}, 11:46:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:46:49 INFO - 'tests': ['a11yr', 11:46:49 INFO - 'ts_paint', 11:46:49 INFO - 'tpaint', 11:46:49 INFO - 'sessionrestore', 11:46:49 INFO - 'sessionrestore_no_auto_restore']}, 11:46:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:46:49 INFO - 'tests': ['a11yr', 11:46:49 INFO - 'ts_paint', 11:46:49 INFO - 'tpaint', 11:46:49 INFO - 'sessionrestore', 11:46:49 INFO - 'sessionrestore_no_auto_restore']}, 11:46:49 INFO - 'other_l64': {'tests': ['a11yr', 11:46:49 INFO - 'ts_paint', 11:46:49 INFO - 'tpaint', 11:46:49 INFO - 'sessionrestore', 11:46:49 INFO - 'sessionrestore_no_auto_restore']}, 11:46:49 INFO - 'other_nol64': {'tests': ['a11yr', 11:46:49 INFO - 'ts_paint', 11:46:49 INFO - 'tpaint', 11:46:49 INFO - 'sessionrestore', 11:46:49 INFO - 'sessionrestore_no_auto_restore']}, 11:46:49 INFO - 'svgr': {'tests': ['tsvgx', 11:46:49 INFO - 'tsvgr_opacity', 11:46:49 INFO - 'tart', 11:46:49 INFO - 'tscrollx', 11:46:49 INFO - 'cart']}, 11:46:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:46:49 INFO - 'tests': ['tsvgx', 11:46:49 INFO - 'tsvgr_opacity', 11:46:49 INFO - 'tart', 11:46:49 INFO - 'tscrollx', 11:46:49 INFO - 'cart']}, 11:46:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:46:49 INFO - 'tests': ['tp5o']}, 11:46:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:46:49 INFO - 'talos_options': ['--e10s'], 11:46:49 INFO - 'tests': ['tp5o']}, 11:46:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:46:49 INFO - 'talos_options': ['--xperf_path', 11:46:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:46:49 INFO - 'tests': ['tp5n']}, 11:46:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:46:49 INFO - 'talos_options': ['--e10s', 11:46:49 INFO - '--xperf_path', 11:46:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 11:46:49 INFO - 'C:/slave/talos-data/talos/xperf.config'], 11:46:49 INFO - 'tests': ['tp5n']}}, 11:46:49 INFO - 'talos.zip': {'path': '', 11:46:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:46:49 INFO - Running post-action listener: _resource_record_post_action 11:46:49 INFO - ##### 11:46:49 INFO - ##### Running create-virtualenv step. 11:46:49 INFO - ##### 11:46:49 INFO - Running pre-action listener: _resource_record_pre_action 11:46:49 INFO - Running main action method: create_virtualenv 11:46:49 INFO - Creating virtualenv /builds/slave/test/build/venv 11:46:49 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:46:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:46:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:46:49 INFO - Using real prefix '/tools/python27' 11:46:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:46:50 INFO - Installing distribute.............................................................................................................................................................................................done. 11:46:54 INFO - Installing pip.................done. 11:46:54 INFO - Return code: 0 11:46:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:46:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:46:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:46:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106372a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063df228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8dd84512e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063279f0>, '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 0x106086cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1062f1990>, '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.tEu47zSKc1/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.4ldzly0Q3v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/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 11:46:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:46:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:46:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tEu47zSKc1/Render', 11:46:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:46:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:46:54 INFO - 'HOME': '/Users/cltbld', 11:46:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:46:54 INFO - 'LOGNAME': 'cltbld', 11:46:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:46:54 INFO - 'MOZ_NO_REMOTE': '1', 11:46:54 INFO - 'NO_EM_RESTART': '1', 11:46:54 INFO - 'PAGER': '/bin/cat', 11:46:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:46:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:46:54 INFO - 'PWD': '/builds/slave/test', 11:46:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:46:54 INFO - 'SHELL': '/bin/bash', 11:46:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4ldzly0Q3v/Listeners', 11:46:54 INFO - 'TMPDIR': '/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/', 11:46:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:46:54 INFO - 'USER': 'cltbld', 11:46:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:46:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:46:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:46:54 INFO - 'XPC_FLAGS': '0x0', 11:46:54 INFO - 'XPC_SERVICE_NAME': '0', 11:46:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 11:46:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:46:54 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:46:54 INFO - Cleaning up... 11:46:54 INFO - Return code: 0 11:46:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:46:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:46:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:46:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106372a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063df228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8dd84512e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063279f0>, '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 0x106086cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1062f1990>, '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.tEu47zSKc1/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.4ldzly0Q3v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/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 11:46:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 11:46:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 11:46:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tEu47zSKc1/Render', 11:46:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:46:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:46:54 INFO - 'HOME': '/Users/cltbld', 11:46:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:46:54 INFO - 'LOGNAME': 'cltbld', 11:46:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:46:54 INFO - 'MOZ_NO_REMOTE': '1', 11:46:54 INFO - 'NO_EM_RESTART': '1', 11:46:54 INFO - 'PAGER': '/bin/cat', 11:46:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:46:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:46:54 INFO - 'PWD': '/builds/slave/test', 11:46:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:46:54 INFO - 'SHELL': '/bin/bash', 11:46:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4ldzly0Q3v/Listeners', 11:46:54 INFO - 'TMPDIR': '/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/', 11:46:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:46:54 INFO - 'USER': 'cltbld', 11:46:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:46:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:46:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:46:54 INFO - 'XPC_FLAGS': '0x0', 11:46:54 INFO - 'XPC_SERVICE_NAME': '0', 11:46:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 11:46:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:46:54 INFO - Downloading/unpacking psutil>=0.7.1 11:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:46:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:46:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:46:57 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 11:46:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 11:46:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:46:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:46:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:46:57 INFO - Installing collected packages: psutil 11:46:57 INFO - Running setup.py install for psutil 11:46:57 INFO - building 'psutil._psutil_osx' extension 11:46:57 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 11:46:58 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 11:46:58 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 11:46:58 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 11:46:58 INFO - building 'psutil._psutil_posix' extension 11:46:58 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 11:46:58 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:46:58 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:46:58 INFO - ^ 11:46:58 INFO - 1 warning generated. 11:46:58 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 11:46:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:46:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:46:58 INFO - Successfully installed psutil 11:46:58 INFO - Cleaning up... 11:46:58 INFO - Return code: 0 11:46:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:46:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:46:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:46:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:46:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:58 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 0x106372a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063df228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8dd84512e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063279f0>, '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 0x106086cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1062f1990>, '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.tEu47zSKc1/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.4ldzly0Q3v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/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 11:46:58 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 11:46:58 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 11:46:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tEu47zSKc1/Render', 11:46:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:46:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:46:58 INFO - 'HOME': '/Users/cltbld', 11:46:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:46:58 INFO - 'LOGNAME': 'cltbld', 11:46:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:46:58 INFO - 'MOZ_NO_REMOTE': '1', 11:46:58 INFO - 'NO_EM_RESTART': '1', 11:46:58 INFO - 'PAGER': '/bin/cat', 11:46:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:46:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:46:58 INFO - 'PWD': '/builds/slave/test', 11:46:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:46:58 INFO - 'SHELL': '/bin/bash', 11:46:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4ldzly0Q3v/Listeners', 11:46:58 INFO - 'TMPDIR': '/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/', 11:46:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:46:58 INFO - 'USER': 'cltbld', 11:46:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:46:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:46:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:46:58 INFO - 'XPC_FLAGS': '0x0', 11:46:58 INFO - 'XPC_SERVICE_NAME': '0', 11:46:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 11:46:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:46:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:46: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 11:46: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 11:46: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 11:46: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 11:46: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 11:46: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 11:47:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:47:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 11:47:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:47:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:47:01 INFO - Installing collected packages: mozsystemmonitor 11:47:01 INFO - Running setup.py install for mozsystemmonitor 11:47:01 INFO - Successfully installed mozsystemmonitor 11:47:01 INFO - Cleaning up... 11:47:02 INFO - Return code: 0 11:47:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:47:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:02 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 0x106372a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063df228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8dd84512e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063279f0>, '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 0x106086cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1062f1990>, '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.tEu47zSKc1/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.4ldzly0Q3v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/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 11:47:02 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 11:47:02 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 11:47:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tEu47zSKc1/Render', 11:47:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:47:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:47:02 INFO - 'HOME': '/Users/cltbld', 11:47:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:47:02 INFO - 'LOGNAME': 'cltbld', 11:47:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:02 INFO - 'MOZ_NO_REMOTE': '1', 11:47:02 INFO - 'NO_EM_RESTART': '1', 11:47:02 INFO - 'PAGER': '/bin/cat', 11:47:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:47:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:02 INFO - 'PWD': '/builds/slave/test', 11:47:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:47:02 INFO - 'SHELL': '/bin/bash', 11:47:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4ldzly0Q3v/Listeners', 11:47:02 INFO - 'TMPDIR': '/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/', 11:47:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:47:02 INFO - 'USER': 'cltbld', 11:47:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:47:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:47:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:02 INFO - 'XPC_FLAGS': '0x0', 11:47:02 INFO - 'XPC_SERVICE_NAME': '0', 11:47:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 11:47:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:02 INFO - Downloading/unpacking blobuploader==1.2.4 11:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:47:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:04 INFO - Downloading blobuploader-1.2.4.tar.gz 11:47:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 11:47:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:47:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:47:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 11:47:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:47:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:47:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:06 INFO - Downloading docopt-0.6.1.tar.gz 11:47:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 11:47:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:47:06 INFO - Installing collected packages: blobuploader, requests, docopt 11:47:06 INFO - Running setup.py install for blobuploader 11:47:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:47:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:47:06 INFO - Running setup.py install for requests 11:47:07 INFO - Running setup.py install for docopt 11:47:07 INFO - Successfully installed blobuploader requests docopt 11:47:07 INFO - Cleaning up... 11:47:07 INFO - Return code: 0 11:47:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:47:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:47:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:07 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 0x106372a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063df228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8dd84512e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063279f0>, '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 0x106086cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1062f1990>, '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.tEu47zSKc1/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.4ldzly0Q3v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/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 11:47:07 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 11:47:07 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 11:47:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tEu47zSKc1/Render', 11:47:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:47:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:47:07 INFO - 'HOME': '/Users/cltbld', 11:47:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:47:07 INFO - 'LOGNAME': 'cltbld', 11:47:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:07 INFO - 'MOZ_NO_REMOTE': '1', 11:47:07 INFO - 'NO_EM_RESTART': '1', 11:47:07 INFO - 'PAGER': '/bin/cat', 11:47:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:47:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:07 INFO - 'PWD': '/builds/slave/test', 11:47:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:47:07 INFO - 'SHELL': '/bin/bash', 11:47:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4ldzly0Q3v/Listeners', 11:47:07 INFO - 'TMPDIR': '/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/', 11:47:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:47:07 INFO - 'USER': 'cltbld', 11:47:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:47:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:47:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:07 INFO - 'XPC_FLAGS': '0x0', 11:47:07 INFO - 'XPC_SERVICE_NAME': '0', 11:47:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 11:47:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:47:07 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-6mrBqp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:47:08 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-5DVky7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:47:08 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-RltSzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:47:08 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-3V8mXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:47:08 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-yUiAyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:47:08 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-Ca4A7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:47:08 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-f7KmzI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:47:08 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-GsKM90-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:47:08 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-e7A_W0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:47:09 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-qS4mZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:47:09 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-COrMsP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:47:09 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-WSu_LF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:47:09 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-hry12P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:47:09 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-JhwVTD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:47:09 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-WEc_iU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:47:09 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-RzaiMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:47:10 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-xigXcg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:47:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:47:10 INFO - Running setup.py install for manifestparser 11:47:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:47:10 INFO - Running setup.py install for mozcrash 11:47:10 INFO - Running setup.py install for mozdebug 11:47:10 INFO - Running setup.py install for mozdevice 11:47:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:47:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:47:10 INFO - Running setup.py install for mozfile 11:47:11 INFO - Running setup.py install for mozhttpd 11:47:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:47:11 INFO - Running setup.py install for mozinfo 11:47:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:47:11 INFO - Running setup.py install for mozInstall 11:47:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:47:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:47:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:47:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:47:11 INFO - Running setup.py install for mozleak 11:47:11 INFO - Running setup.py install for mozlog 11:47:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:47:12 INFO - Running setup.py install for moznetwork 11:47:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:47:12 INFO - Running setup.py install for mozprocess 11:47:12 INFO - Running setup.py install for mozprofile 11:47:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:47:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:47:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:47:12 INFO - Running setup.py install for mozrunner 11:47:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:47:12 INFO - Running setup.py install for mozscreenshot 11:47:13 INFO - Running setup.py install for moztest 11:47:13 INFO - Running setup.py install for mozversion 11:47:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:47:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:47:13 INFO - Cleaning up... 11:47:13 INFO - Return code: 0 11:47:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:47:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:47:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x106372a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063df228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8dd84512e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063279f0>, '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 0x106086cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1062f1990>, '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.tEu47zSKc1/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.4ldzly0Q3v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/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 11:47:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:47:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:47:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tEu47zSKc1/Render', 11:47:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:47:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:47:13 INFO - 'HOME': '/Users/cltbld', 11:47:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:47:13 INFO - 'LOGNAME': 'cltbld', 11:47:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:13 INFO - 'MOZ_NO_REMOTE': '1', 11:47:13 INFO - 'NO_EM_RESTART': '1', 11:47:13 INFO - 'PAGER': '/bin/cat', 11:47:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:47:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:13 INFO - 'PWD': '/builds/slave/test', 11:47:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:47:13 INFO - 'SHELL': '/bin/bash', 11:47:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4ldzly0Q3v/Listeners', 11:47:13 INFO - 'TMPDIR': '/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/', 11:47:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:47:13 INFO - 'USER': 'cltbld', 11:47:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:47:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:47:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:13 INFO - 'XPC_FLAGS': '0x0', 11:47:13 INFO - 'XPC_SERVICE_NAME': '0', 11:47:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 11:47:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:47:13 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-uUXEjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:47:13 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:47:13 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-mVIZuL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:47:14 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)) 11:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:47:14 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-Z7lzlJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:47:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:47:14 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-vzLJx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:47:14 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)) 11:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:47:14 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-g9lrU_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:47:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:47:14 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-123Jji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:47:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:47:14 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-_gJkzW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:47:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:47:14 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-3AePFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:47:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:47:14 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-XcWMWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:47:15 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-b06_S7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:47:15 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)) 11:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:47:15 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-vB6VRl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:47:15 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-Bc7YKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:47:15 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-WuhabM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:47:15 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)) 11:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:47:15 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-wFzOMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:47:15 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-ALMp0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:47:15 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-MYyaPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:47:16 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-Ofq57i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:47:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:47:16 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)) 11:47:16 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)) 11:47:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:47:16 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)) 11:47:16 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)) 11:47:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:47:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:18 INFO - Downloading blessings-1.5.1.tar.gz 11:47:18 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 11:47:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:47:18 INFO - Installing collected packages: blessings 11:47:18 INFO - Running setup.py install for blessings 11:47:19 INFO - Successfully installed blessings 11:47:19 INFO - Cleaning up... 11:47:19 INFO - Return code: 0 11:47:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:47:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:47:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:47:19 INFO - Reading from file tmpfile_stdout 11:47:19 INFO - Current package versions: 11:47:19 INFO - blessings == 1.5.1 11:47:19 INFO - blobuploader == 1.2.4 11:47:19 INFO - docopt == 0.6.1 11:47:19 INFO - manifestparser == 1.1 11:47:19 INFO - mozInstall == 1.12 11:47:19 INFO - mozcrash == 0.16 11:47:19 INFO - mozdebug == 0.1 11:47:19 INFO - mozdevice == 0.47 11:47:19 INFO - mozfile == 1.2 11:47:19 INFO - mozhttpd == 0.7 11:47:19 INFO - mozinfo == 0.9 11:47:19 INFO - mozleak == 0.1 11:47:19 INFO - mozlog == 3.0 11:47:19 INFO - moznetwork == 0.27 11:47:19 INFO - mozprocess == 0.22 11:47:19 INFO - mozprofile == 0.27 11:47:19 INFO - mozrunner == 6.11 11:47:19 INFO - mozscreenshot == 0.1 11:47:19 INFO - mozsystemmonitor == 0.0 11:47:19 INFO - moztest == 0.7 11:47:19 INFO - mozversion == 1.4 11:47:19 INFO - psutil == 3.1.1 11:47:19 INFO - requests == 1.2.3 11:47:19 INFO - wsgiref == 0.1.2 11:47:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:47:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:47:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:19 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 0x106372a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063df228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8dd84512e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063279f0>, '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 0x106086cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1062f1990>, '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.tEu47zSKc1/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.4ldzly0Q3v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/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 11:47:19 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 11:47:19 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 11:47:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tEu47zSKc1/Render', 11:47:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:47:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:47:19 INFO - 'HOME': '/Users/cltbld', 11:47:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:47:19 INFO - 'LOGNAME': 'cltbld', 11:47:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:19 INFO - 'MOZ_NO_REMOTE': '1', 11:47:19 INFO - 'NO_EM_RESTART': '1', 11:47:19 INFO - 'PAGER': '/bin/cat', 11:47:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:47:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:19 INFO - 'PWD': '/builds/slave/test', 11:47:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:47:19 INFO - 'SHELL': '/bin/bash', 11:47:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4ldzly0Q3v/Listeners', 11:47:19 INFO - 'TMPDIR': '/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/', 11:47:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:47:19 INFO - 'USER': 'cltbld', 11:47:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:47:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:47:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:19 INFO - 'XPC_FLAGS': '0x0', 11:47:19 INFO - 'XPC_SERVICE_NAME': '0', 11:47:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 11:47:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:19 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)) 11:47:19 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)) 11:47:19 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)) 11:47:19 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)) 11:47:19 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)) 11:47:19 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)) 11:47:19 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)) 11:47:19 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)) 11:47:19 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)) 11:47:19 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)) 11:47:19 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)) 11:47:19 INFO - Cleaning up... 11:47:19 INFO - Return code: 0 11:47:19 INFO - Running post-action listener: _resource_record_post_action 11:47:19 INFO - Running post-action listener: _start_resource_monitoring 11:47:19 INFO - Starting resource monitoring. 11:47:19 INFO - ##### 11:47:19 INFO - ##### Running install step. 11:47:19 INFO - ##### 11:47:19 INFO - Running pre-action listener: _resource_record_pre_action 11:47:19 INFO - Running main action method: install 11:47:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:47:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:47:20 INFO - Reading from file tmpfile_stdout 11:47:20 INFO - Detecting whether we're running mozinstall >=1.0... 11:47:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:47:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:47:20 INFO - Reading from file tmpfile_stdout 11:47:20 INFO - Output received: 11:47:20 INFO - Usage: mozinstall [options] installer 11:47:20 INFO - Options: 11:47:20 INFO - -h, --help show this help message and exit 11:47:20 INFO - -d DEST, --destination=DEST 11:47:20 INFO - Directory to install application into. [default: 11:47:20 INFO - "/builds/slave/test"] 11:47:20 INFO - --app=APP Application being installed. [default: firefox] 11:47:20 INFO - mkdir: /builds/slave/test/build/application 11:47:20 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'] 11:47:20 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 11:48:01 INFO - Reading from file tmpfile_stdout 11:48:01 INFO - Output received: 11:48:01 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:48:01 INFO - Running post-action listener: _resource_record_post_action 11:48:01 INFO - ##### 11:48:01 INFO - ##### Running run-tests step. 11:48:01 INFO - ##### 11:48:01 INFO - Running pre-action listener: _resource_record_pre_action 11:48:01 INFO - Running main action method: run_tests 11:48:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:48:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:48:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:48:01 INFO - 2015-11-06 11:48:01.285 screenresolution[2254:19533] starting screenresolution argv=screenresolution get 11:48:01 INFO - 2015-11-06 11:48:01.289 screenresolution[2254:19533] Display 0: 1600x1200x32@60 11:48:01 INFO - 2015-11-06 11:48:01.296 screenresolution[2255:19535] starting screenresolution argv=screenresolution list 11:48:01 INFO - Available Modes on Display 0 11:48:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:48:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:48:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:48:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:48:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:48:01 INFO - Intel HD Graphics 3000: 11:48:01 INFO - Chipset Model: Intel HD Graphics 3000 11:48:01 INFO - Type: GPU 11:48:01 INFO - Bus: Built-In 11:48:01 INFO - VRAM (Total): 512 MB 11:48:01 INFO - VRAM (Dynamic, Max): 10 11:48:01 INFO - Vendor: Intel (0x8086) 11:48:01 INFO - Device ID: 0x0116 11:48:01 INFO - Revision ID: 0x0009 11:48:01 INFO - Displays: 11:48:01 INFO - Display: 11:48:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:48:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:48:01 INFO - Display Serial Number: 1600x1200 60 11:48:01 INFO - Main Display: Yes 11:48:01 INFO - Mirror: Off 11:48:01 INFO - Online: Yes 11:48:01 INFO - Rotation: Supported 11:48:01 INFO - Return code: 0 11:48:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:48:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:48:01 INFO - Python 2.7.3 11:48:01 INFO - Return code: 0 11:48:01 INFO - grabbing minidump binary from tooltool 11:48:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:48:01 INFO - 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 0x1063279f0>, '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 0x106086cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1062f1990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:48:01 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:48:01 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 11:48:01 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:48:01 INFO - Return code: 0 11:48:01 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:48:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:48:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:48:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:48:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:48:01 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', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/2LkZYG3HTmaPgd6O0Zsr7g/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0052', '--webServer', 'localhost'] in /builds/slave/test/build 11:48:01 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 --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/2LkZYG3HTmaPgd6O0Zsr7g/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0052 --webServer localhost 11:48:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tEu47zSKc1/Render', 11:48:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:48:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:48:01 INFO - 'HOME': '/Users/cltbld', 11:48:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:48:01 INFO - 'LOGNAME': 'cltbld', 11:48:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:48:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:48:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:01 INFO - 'MOZ_NO_REMOTE': '1', 11:48:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:48:01 INFO - 'NO_EM_RESTART': '1', 11:48:01 INFO - 'PAGER': '/bin/cat', 11:48:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:48:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:01 INFO - 'PWD': '/builds/slave/test', 11:48:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:48:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:48:01 INFO - 'SHELL': '/bin/bash', 11:48:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4ldzly0Q3v/Listeners', 11:48:01 INFO - 'TMPDIR': '/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/', 11:48:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:48:01 INFO - 'USER': 'cltbld', 11:48:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:48:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:48:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:01 INFO - 'XPC_FLAGS': '0x0', 11:48:01 INFO - 'XPC_SERVICE_NAME': '0', 11:48:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 11:48:01 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', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/2LkZYG3HTmaPgd6O0Zsr7g/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0052', '--webServer', 'localhost'] with output_timeout 3600 11:48:01 INFO - mozversion INFO | application_buildid: 20151105001636 11:48:01 INFO - mozversion INFO | application_changeset: ff8ebe5251ec227be26994089871cb40c1da3011 11:48:01 INFO - mozversion INFO | application_display_name: Nightly 11:48:01 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:48:01 INFO - mozversion INFO | application_name: Firefox 11:48:01 INFO - mozversion INFO | application_remotingname: firefox 11:48:01 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 11:48:01 INFO - mozversion INFO | application_vendor: Mozilla 11:48:01 INFO - mozversion INFO | application_version: 45.0a1 11:48:01 INFO - mozversion INFO | platform_buildid: 20151105001636 11:48:01 INFO - mozversion INFO | platform_changeset: ff8ebe5251ec227be26994089871cb40c1da3011 11:48:01 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 11:48:01 INFO - mozversion INFO | platform_version: 45.0a1 11:48:01 INFO - 2015-11-06 11:48:01,976 DEBUG : using testdate: 1446839281 11:48:01 INFO - 2015-11-06 11:48:01,976 DEBUG : actual date: 1446839281 11:48:01 INFO - 2015-11-06 11:48:01,987 INFO : starting webserver on 'localhost:50024' 11:48:01 INFO - 2015-11-06 11:48:01,988 INFO : Starting test suite t-yosemite-r5-0052 11:48:01 INFO - 2015-11-06 11:48:01,988 INFO : Starting test dromaeo_css 11:48:01 INFO - 2015-11-06 11:48:01,988 DEBUG : operating with platform_type : mac_ 11:48:01 INFO - 2015-11-06 11:48:01,989 INFO : Initialising browser for dromaeo_css test... 11:48:02 INFO - 2015-11-06 11:48:02,004 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/tmp6n9Vuy/profile http://localhost:50024/getInfo.html 11:48:04 INFO - 2015-11-06 11:48:04,433 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:48:04 INFO - 2015-11-06 11:48:04,433 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:48:04 INFO - 2015-11-06 11:48:04,433 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 11:48:04 INFO - 2015-11-06 11:48:04,434 DEBUG : BROWSER_OUTPUT: __metrics 11:48:04 INFO - 2015-11-06 11:48:04,450 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:48:05 INFO - 2015-11-06 11:48:05,190 INFO : Browser initialized. 11:48:05 INFO - 2015-11-06 11:48:05,190 INFO : Running cycle 1/1 for dromaeo_css test... 11:48:05 INFO - 2015-11-06 11:48:05,190 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/tmp6n9Vuy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:48:17 INFO - 2015-11-06 11:48:17,221 DEBUG : BROWSER_OUTPUT: RSS: Main: 220794880 11:48:17 INFO - 2015-11-06 11:48:17,221 DEBUG : BROWSER_OUTPUT: 11:49:09 INFO - 2015-11-06 11:49:09,005 DEBUG : BROWSER_OUTPUT: 1446839348995 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:51:18 INFO - 2015-11-06 11:51:18,882 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50024/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50024/tests/dromaeo/cssquery-ext.html) 11:51:20 INFO - 2015-11-06 11:51:20,197 DEBUG : BROWSER_OUTPUT: RSS: Main: 307810304 11:51:20 INFO - 2015-11-06 11:51:20,197 DEBUG : BROWSER_OUTPUT: 11:54:22 INFO - 2015-11-06 11:54:22,959 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50024/tests/dromaeo/cssquery-ext.html (next: http://localhost:50024/tests/dromaeo/cssquery-jquery.html) 11:54:23 INFO - 2015-11-06 11:54:23,541 DEBUG : BROWSER_OUTPUT: RSS: Main: 358469632 11:54:23 INFO - 2015-11-06 11:54:23,541 DEBUG : BROWSER_OUTPUT: 11:57:25 INFO - 2015-11-06 11:57:25,683 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50024/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50024/tests/dromaeo/cssquery-mootools.html) 11:57:26 INFO - 2015-11-06 11:57:26,271 DEBUG : BROWSER_OUTPUT: RSS: Main: 325341184 11:57:26 INFO - 2015-11-06 11:57:26,272 DEBUG : BROWSER_OUTPUT: 12:00:28 INFO - 2015-11-06 12:00:28,495 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50024/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50024/tests/dromaeo/cssquery-prototype.html) 12:00:29 INFO - 2015-11-06 12:00:29,077 DEBUG : BROWSER_OUTPUT: RSS: Main: 310366208 12:00:29 INFO - 2015-11-06 12:00:29,078 DEBUG : BROWSER_OUTPUT: 12:03:32 INFO - 2015-11-06 12:03:32,148 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50024/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50024/tests/dromaeo/cssquery-yui.html) 12:03:32 INFO - 2015-11-06 12:03:32,775 DEBUG : BROWSER_OUTPUT: RSS: Main: 311681024 12:03:32 INFO - 2015-11-06 12:03:32,775 DEBUG : BROWSER_OUTPUT: 12:06:35 INFO - 2015-11-06 12:06:35,848 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50024/tests/dromaeo/cssquery-yui.html (next: http://localhost:50024/tests/dromaeo/cssquery-dojo.html) 12:06:36 INFO - 2015-11-06 12:06:36,113 DEBUG : BROWSER_OUTPUT: RSS: Main: 358576128 12:06:36 INFO - 2015-11-06 12:06:36,114 DEBUG : BROWSER_OUTPUT: 12:06:36 INFO - 2015-11-06 12:06:36,114 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:06:36 INFO - 2015-11-06 12:06:36,114 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:06:36 INFO - 2015-11-06 12:06:36,114 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:06:36 INFO - 2015-11-06 12:06:36,114 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:06:36 INFO - 2015-11-06 12:06:36,114 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2702.9864850675744;2739.1919383781783;2752.8348299102054;2796.2456979874833;2796.8601569921498;4511.120331535352;4622.838200662977;4632.814687412504;4644.5819876211135;4646.883827904304;4482.1035792841485;4603.7237765734;4618.214903466419;4805.351277577526;4830.2754586812;4260.42484264625;4274.615284624383;4298.763568003758;4361.60745532902;4375.803088860993;4302.892427689317;4327.610515053644;4333.65330773539;4350.15172041452;4369.279068953619;4094.5700701426517;4179.373094035888;4214.557471465482;4309.762963037032;4361.43301370823;4069.97965010176;4198.223328684173;4221.409002739619;4252.574742525722;4288.849890253826;4333.566643335641;4335;4339.110482351142;4343.413639158704;4386.166628340605;4407.735535867858;4644.442666879962;4657.790399432034;4676.205045142334;4762.047590481918;4799.6400269979895;4832;4835.2505361669;4849.806007759686;4966.726830024347;5019.397672279313;5022.397312322508;5047.167217409123;5080.288759573663;5113.002964421939;4475.1049790042125;4722.197226471508;4739.691920025188;4743.217369134089;4762.976185119052;4880.829170978998;4992.101421744048;5012.097822391932;5063.87340316495;5125.051865404837;4893.437254715682;4921.803127874845;4936.432310284292;4992.700437973734;5019.874503137451;4838.637102217348;4969.950300497021;5011.924821127686;5067.569256613156;5069.467705890902;4792.185328494094;4819.2530157825595;4826.8069277228515;4940.184869496565;4941.036497882878;4966.379202599675;4972.7513624318635;5010.674306170087;5020.096382651158;5067.771950262247;3921.2353591049473;3925.666318362914;3930.449737036817;3955.4462375267485;3991.1419044904906;3375.1224681582967;3404.268082362304;3487.3199726053176;3508.052825737088;3580.373434648926;4632.189366860786;4646.8141274348645;4685.906281874343;4687.343771871941;4743.312219728189;4973.079980203674;5044.117279476077;5044.142495775727;5049.772760225798;5052.671576347526;4423.646108311327;4463.375127482155;4490.7754612269255;4554.63562914966;4667.906641867212;4342;4390.121975604892;4393;4476.903158726133;4490.820367185342;5019.52314530119;5029.597632189416;5031.924521132186;5086.186210206423;5124.30821839047;4837.395325584302;4925.014997000542;4928.6057115431395;4934.01319736047;5037.949620503748;4870.829520966749;4974.502549744997;5015.774290157025;5037.571806396498;5072.289879416959;4893.608511319015;4898.387701537308;4940.802367905244;4960.379952505937;5001.699898006132;4967.304577359245;5007.899842003212;5028.446870844131;5041.722705251246;5056.191009438472;4632.119897219518;4666.78999445019;4773.355596994361;4805.639577031667;4859.927101093415;4883.096627123993;4932.704037757746;4945.554900059012;4957.950420495749;5008.799648014038;4787.114383838862;4806.255030470283;4878.975605121952;4881.072596206709;4892.902141957212;4644.7213167210075;4738.905221895612;4758.97681998372;4808.182608956556;4918.114739346952;4745.098431298043;4821.397325334333;4842.685225460334;4866.367372241586;4917.754112294442 12:06:36 INFO - 2015-11-06 12:06:36,115 DEBUG : BROWSER_OUTPUT: |1;ext.html;465.98136074557016;467.1731036066163;478.66015129258227;485.9416869975601;503.20996036223096;27190.592141117875;27679.16962491126;31690.366192676134;32043.67956320436;32150;35195;36018.2796344073;36057.63942360575;36159.276814463694;36199.475065616796;6965.616891070989;7844.92155078449;7897.921020789805;8042.276195142436;8042.959785201066;4797.9760101199445;4804.975975120119;4875.171220892439;5256.290400795881;7118.893216601755;9107.089291070906;9174;9195.632174713004;9312.068793120701;9461.57422915967;5314.707691076989;7193;7456.217097204824;9106.408083474553;9263.120003599648;9143.497107659075;9148.634054637872;9304.30217733666;9340.859887101698;9380.5309734513;32943;33518.32963340744;33565.49651755226;33602.6639733602;33772;2540.61890716394;2591.598302263152;2617.0971014999795;2618.9214323570322;2679.3971356444645;23400;23865.284041478782;23991;24195;24553.14064007769;2087.1651339464183;2105.4525823285903;2129.446343950584;2145.313499680103;2241.4284357488737;234905;235010;235103;237292;238397;43176;51037;51747.223791643155;51811.74094129505;51818;40892;41181.38227926583;53419.73290133524;54449.72775136099;54601.726991365584;14080.71838563223;14117.223552704494;14131.78802317966;14208.715825683428;14249;10885.510152043176;10922.344659320466;10962.451877406098;11029;11035.44822758859;16486.258118384703;16687.582810429838;16711.331546737994;16743.748843767353;16811.579710507336;7268.418526517866;7437.219091995263;7463.664135113933;7464.768313228256;7469.327760501472;781.2929298984428;781.9765407037798;873.7990262239721;881.6385282034463;888.2583043159035;24288.1499147529;24366.75633243645;24427.511449770904;24924.252272431855;25136.24591262265;927.3137877970254;930.4835816121982;933.9533023348805;997.5012493753123;1001.5743309093606;12280.570180043835;12361.567345142877;12413.379331033413;12460.501579936883;12839.550615728405;267735;271496;275330;275346;276522;47583.76208118937;47808.760956194994;48170.27744583834;48226;48386;1194.199886076331;1198.7592841408925;1213.5873802907054;1216.4586758892385;1218.0925210717894;20745.89627051855;24105.276841694777;24647.50704985926;24649;24666.260012199662;38024.429633554966;38429;38453.80773096117;38543.80728096342;38676.226475470896;226124;227330;227452;227729;228422;22602.434939126655;23016.194433194756;23051.654225186972;25537.361565961;25772.484550309266;33817.83091084529;33875.4918676225;34685;34847.65152348444;35314.47028294629;26710.86644566765;27156.333894923933;27919.162425127277;28062.2984425391;28315.575266370608;28170.577441338806;28464.573031404132;28589.428211436072;29113.7088629111;29321.85339073291;29312.120636380943;29337;29882.103536893927;29883.70116298809;30361.848190758905;25216.74783252144;26443.867780660974;26622.7337726628;26727.465450691267;26926;20268.290609829175;20533.0257224608;20566.588668226254;20602.484937876074;20697.17099364471 12:06:36 INFO - 2015-11-06 12:06:36,115 DEBUG : BROWSER_OUTPUT: |2;jquery.html;292.1119795820705;292.35243934684667;293.55233269264374;300.64073432248466;302.00489387468303;14407.423703051878;14451.710965780705;14551.05418147821;14772.261386930637;14943.925280373596;14514;14534;15300.464483743071;15343;15395.846041539582;4497.190505708971;4522.592966632994;4634.629229661636;4643.698159619631;4701.576858082772;4660.86017419478;4661.044485880403;4669.743164125972;4670.182718024332;4679.625629949613;4527.049319642879;4636.629069674418;4637.397138372007;4653.534646535353;4690.0854333405;4575;4598.816047358118;4600.102979918884;4610.792514336863;4624.606908412772;4035.1324465240114;4058.1275025869286;4059.939100913489;4064.065264989069;4072.4705788247634;17532.824671753246;18159.909200454047;18463.538411539685;18503.352382666675;18598.44204673862;1645.7449095390234;1729.7751292332043;1780.1455301455374;1842.2907180735378;1907.761529808774;10805.513751881106;10980.560777568888;11200.607978720705;11248.662540123809;11512.251703639236;1405.1779708870222;1424.950126745559;1425.4013314407973;1485.6880055188424;1490.941431583566;41050.38424423636;42266.999999999694;44503;48614.513854861354;49599.75200124012;8147.388945829087;8354.498730076215;8394.706185283485;8425.95787021061;8483.066862645104;9614.51927403627;9698.70903872885;9773.267004974656;9928.702138935843;10080.143187829117;6909.481788865754;7024.613646249403;7035.507514473938;7043.964780176067;7044.894326585106;7300.56196628204;7330.8900366494545;7337.046183996046;7339.412846972336;7395.371393431511;4935.8519244422005;5011.09800235961;5019.322391477177;5036.345275114211;5038.84883453497;1436.2746812859648;1438.2089850582138;1438.3671184678708;1441.3081720774087;1460.8685218330402;773.5629369406267;812.1504070704934;830.1449507007792;857.9313654907593;890.643742503004;10078.697639070839;10138;10209.795804083877;15492.690146197237;16159.43441979525;350.7124158190259;398.07646260674954;407.20391634355354;415.19866657350997;419.7628339987958;5246.554042906319;5453.157813349505;5487.945120548743;5576.330840299109;5597.580181486404;478380;484911;489437;490441;494035;35218.71719242134;44470;48743.5125648746;61857;63821.361786381545;429.7035045818438;438.537343103023;438.8815019944661;441.8873187337273;446.6181414890287;9379.390339627902;9399.436033837992;9412.95293523528;9527.809443811224;9560.330776845554;29155.562666560443;29458.410831783673;29610.851945740134;30089.796408144306;30111.09666710002;40917;41314.79342603268;41322.79338603288;41616.79191604144;41781.79109104557;4806.279058141306;5213.530782229617;5287.154055351125;5289.20661900718;5341.198820177005;9746.80506389854;9841.557129929028;9956.452395118338;9976.850347244943;9976.900230997888;8495.490270583785;8519.659213631385;8647.481151130953;8768;8774.912250877665;8385.622646981023;8437.240648341678;8445.451045682012;8481.27909127731;8593.52735599523;8582.141785821368;8684.696035638723;8688.218060374596;8781.956090219508;8846.248068914214;5213.061648903082;5248.343957005374;5256.4743525648655;5267.631265811357;5270.657407268515;8332.125126861592;8447.704330348408;8713.91286087131;8763.693270735494;8801.955990220007 12:06:36 INFO - 2015-11-06 12:06:36,115 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1093.8140516112271;1486.086057074899;1553.7358649029663;1568.4902406717815;1576.9053856768587;5737.913931291034;6110.816675499736;6241.687915604224;6319.77880774173;6367.172267605205;6221.657808820513;6274.341194174603;6330.240371155468;6335.461485773715;6345.428911397973;1898.2027548429623;1920.3374835681668;1922.9134688939032;1928.874623149498;1930.362980216525;1841.1622711666228;1848.0759620189906;1854.8330650241476;1865.4496923407628;1873.906304684767;1850.2598960415874;1871.9906400467978;1873.5035215667858;1874.1753628403526;1877.643247782917;1815.8093400192988;1821.9180136893872;1830.880992735468;1843.7695288089055;1853.379117995473;1835.1374853818684;1848.574827789616;1865.0395046551037;1871.4759867237196;1881.5672395349147;5628.240187574666;6246.3441338659695;6259.968700156515;6282.465990390822;6285.497160227171;3572.1962558424407;3808.409696497047;3906.8632597859223;3954.426608141803;3957.525096988351;2419.70963484383;2518.1312447205682;2548.643189953408;2555.565553855849;2559.9104031358997;770.2990278846223;794.7695168401157;795.4074214710021;805.399977017126;827.1728271728272;8026.959865200637;8177.4684645497855;8202.015758109064;8206.83586328276;8225.588720563948;3389.322135572895;3445.8277086145595;3492.2666240089357;3502.3345564342694;3533.7526373154146;6829.419499342513;6830.658467076626;6864.039034535169;6872.381485666314;6884.0362349271145;3940.014996250937;3943.0536671198706;3944.9408258876138;3951.2295102454746;3970.82131304092;3654.1230104774663;3663.230721548505;3682.742208045411;3689.7048236141045;3717.4423836424753;2744.464829358296;2761.351082495612;2788.9721102788712;2791.441711657636;2795.9301017474727;811.4968719394013;817.5421763812284;825.0841565861889;838.3837879158814;838.8825564420986;900.4732231644431;943.8772959515219;1145.2613064573304;1159.5419809175328;1159.6694941941507;6014.51883849291;6094.695265236721;6112.816615501542;6125.203723515914;6139.508839292936;900.8243392538392;910.3991365698607;928.224932181636;1000.799840031982;1018.6129270877168;4889.755512224375;4905.730184839868;4943.406791185081;4950.405951285797;4959.553640172329;7083.610401427868;7179.389751871149;7300.744473943492;7459.515131516434;7486.775396738107;7359.264073592705;7400.740974065882;7434.442416818761;7446.73936412223;7461.962690186514;5887.587868849225;5888.087346461305;5978.790742324085;6029.939700602938;6030.849228769228;5967.8209653710455;5972.850678733066;5976.940230597638;5983.401659834156;5996.5502587305255;6627.867442651216;6692.263850976291;6833.3166683331265;6834.760783372558;6848.452123829982;6763.797086087426;6871.209810871614;6912.101426814482;6932.376086152271;6987.510874238755;5164.664296820694;5267.631265811357;5290.947090529045;5308.548773354308;5315.920261196163;5711.942880571141;6107.480864126422;6134.171886795226;6140.815775526741;6164.47601953839;5492.258545096361;5620.971895140498;5691.914621280767;5757.971210143923;5797.9420205797405;5307.230451584576;5506.311711036121;5664.348599910898;5696.971515142398;5709.543236540983;5709.115087161496;5770.394108618535;5796.130580412803;5806.796762113475;5839.824805255849;5246.31797866275;5301.814436494704;5309.654872433434;5327.840164795062;5334.039872822929;5034.672746271481;5144.562712169508;5155.716435596079;5155.948440515547;5354.54486368663 12:06:36 INFO - 2015-11-06 12:06:36,115 DEBUG : BROWSER_OUTPUT: |4;prototype.html;269.66561463784905;279.7691904179052;280.9213420242333;282.27314664738293;288.6406424002118;5229.660072095311;5238.13570760824;5241.659292146008;5247.134222853229;5272.393674727403;4990.65065445419;5050.520200580948;5115.079285728568;5118.283440318349;5140.357455318085;3963.365861462167;3978.2043591281713;3992.1416895367634;3996.820143093568;4020.4974378202724;3983.661388781957;4005.3791662292247;4007.0783719744477;4011.8796436106963;4017.517897852247;3825.713071519633;3888.9805550972205;3897.941530877039;3987.760734355948;3992.361222204448;3947.032976920644;3974.0263635409365;3994.2810294147043;4005.7997100144876;4017.5982401759884;3405.3189362127428;3408.829558522064;3424.6917777399904;3424.8972530824117;3427.622961474236;4939.061578300148;5036.269740887551;5066.062778385974;5081.085404627165;5120.769565369567;4172.624463798273;4293.957060429387;4453.53237910018;4456.977715111436;4460.910781784379;5342.225377320306;5426.375966763833;5437.728113594344;5443.401225865152;5475;3660.432632941898;3686.1706116123923;3688.2807852468777;3694.538182727159;3710.517632707758;5632.7746890124345;5735.799247026334;5738.483536481736;5749.540036797046;5756.7985120521;3621.7826930384263;3711.814409279525;3729.198222382201;3733.253349330145;3746.756460830037;3787.3182827090836;3828.062124779391;3833.501644786216;3840.8271627776817;3860.034991252187;4463.464384273843;4487.483939346952;4488.192125417456;4488.9102217956115;4500.099980004013;5518.117101263779;5539.446055394428;5540.9168862467095;5557.444255574491;5559.27729395176;1369.664432214114;1377.4696741754497;1382.8271466066742;1391.1792042694858;1397.3711829676686;875.8292133034124;882.1972005475116;897.6768363389175;899.4153800030033;901.8782464367226;5319.255304257407;5332.866678333073;5365.651232669864;5376.247325374451;5387.676739395571;5737.598368114275;5745.770169193269;5750.654960702372;5764.193012978187;5786;5326.946730532645;5339.332583427072;5346.545543628835;5351.25082488452;5364;3076.8153910765427;3150.2439414540345;3175.7459403247685;3195.936081278408;3196.7282780963415;5772.595918285764;5799.710014499258;5828.446297601721;5828.504577110908;5840.795572154954;5869;5888.705564721747;5900.350961394243;5921.703914804242;5929.14027466015;5436.592255580768;5609.887802243932;5826.41735826414;5835.037218858841;5838.620489668158;5686.687232202103;5713.857153571194;5738.22533957927;5742.16738572913;5771.94228057714;5623.268975033219;5640.379558248672;5641.069223578063;5665.688387138747;5682.943170568242;5766.048601980626;5772.826815195551;5784.363719990882;5828.70856457167;5839.124131380157;3697.815109244473;3778.414345776409;3783.5270591176104;3824.655780979725;3827.004978705501;5801.622894511843;5817;5833.883322333614;5835.533157347487;5858.297004359504;5612.859678507906;5623;5624.128260119688;5636.436356364331;5648.604597678123;5465.72671366438;5588.552915766648;5591.804286849941;5622.2128901954575;5653.152027195953;5497.725113744376;5502.284702988586;5502.532284755841;5510.476504732044;5518;5679.261695979496;5687.317521897398;5692.373838877803;5701.743421545957;5705.7147142643535;5501.504864562208;5502.724863756876;5521.585881059017;5522.282103326542;5528.75120619565 12:06:36 INFO - 2015-11-06 12:06:36,116 DEBUG : BROWSER_OUTPUT: |5;yui.html;603.8339456649423;642.7429028388647;657.2474516678403;680.7991642465473;690.2855544511432;12092.818607720881;12325.5069797208;12343.691407714812;12345.444454999524;12374.257544547323;11452;11498.19512634116;11552.075833933286;11599.768004639924;11782.057435405168;615.0681717198448;617.1452538234532;621.0776996160698;744.330102907385;765.6248438265266;763.9847203055936;770.9553554933069;778.8792737125726;779.629675903944;784.3764207455058;809.2150613904503;810.1250649298743;812.9309008734265;814.1288820961573;814.5601375257384;645.3739872323862;659.8746238214771;796.7211475983418;804.5977011494252;819.8852160697508;597.7160848596925;598.1984141250745;601.6089541797822;607.7417097733489;608.4341562347059;11818.290902545874;11983.340916249603;12008.939955300255;12037.518499260019;12122;10097.091261786401;10128;10558.155347572252;10822.404767737771;10857.131429485622;7920.207979202091;8229.947671141348;8279.213474719892;8508.149185081442;8660.566971651393;2834.5889845972424;2889.8266104033823;2903.11455006223;2942.5880376747273;2952.0110762894456;42622.57377426217;42857;43061;43072;43806.56193438057;7909.881351779728;7913.32736717374;7969.362451003905;7996.440249182501;8049.718259860877;17089;17102.40141595063;17250.137493125294;17264.050477223875;17365;5982.940170598238;6200.751969921243;6225.470834978987;6311.96844015777;6366.649834259068;3348.6316505184896;3428.434308339146;3438.9312213755584;3454.3436747017986;3462;2458.6557881896547;2565.9486810264066;2566.230130960704;2570.434504409027;2571.524268010424;364.41329459570073;367.4304827517391;372.2684924124109;373.06733167082297;380.3135340710045;482.65249020705033;501.7315736081252;506.3063602864026;515.3841159814061;532.8055259830212;6324.367563243639;6960.373566378949;7386.630668466555;7440.813979650552;7701.997480654958;457.6316065567184;462.64145287401857;516.0350145228447;523.351839691164;547.3158551810237;3210.646828848825;3220.404225218342;3239.4492936200904;3272.885449009273;3339.4322965095994;48858;48872.26691599629;49403.50596494061;49543.50456495389;49761;41961.79019104885;43132;43247.35128973068;43341.78329108397;43350;39741.20517589632;41178.38232426516;41413.37879931804;41450.585494144674;42253.57746422497;6671.432928201158;6728.192616886005;7119.75080872167;7146.857062858609;7169.978894216608;28747.137585872457;28873.711262887104;29049.12852614425;29502;29553.55669664914;37385.4392184112;37535;41787.79106104572;41993.79003104965;42015.57984420239;6552.148220731275;6579;6584.967075164594;6698.430633396216;6789.898151527632;9553.426794392359;9614.134727874525;9629.807403852024;9644.083812037845;9689;8940.195382415613;8965.686200982935;8987.41581797181;9211.815763684555;9254.814903702023;9060.909390906007;9256;9275.027278026411;9287.257019438293;9437.103475169848;8935.731928041909;9091.409058411182;9236.907630923604;9307.395019323721;9330.160285574331;7574.962125189339;7645;7787;8080.555569443502;8192.44343574719;7591.240875912586;7633.732819351296;7691.769246922601;7711.460197786101;7993.560354180576 12:06:36 INFO - 2015-11-06 12:06:36,117 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:06:36 INFO - 2015-11-06 12:06:36,117 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:06:36 INFO - 2015-11-06 12:06:36,117 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1047 12:06:36 INFO - 2015-11-06 12:06:36,117 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:06:36 INFO - 2015-11-06 12:06:36,117 DEBUG : BROWSER_OUTPUT: __startTimestamp1446840396103__endTimestamp 12:06:36 INFO - 2015-11-06 12:06:36,117 DEBUG : BROWSER_OUTPUT: 12:06:36 INFO - 2015-11-06 12:06:36,119 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:06:36 INFO - 2015-11-06 12:06:36,119 DEBUG : BROWSER_OUTPUT: Number of tests: 6 12:06:36 INFO - 2015-11-06 12:06:36,119 DEBUG : BROWSER_OUTPUT: 12:06:36 INFO - 2015-11-06 12:06:36,119 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4627.31 Median:4799.64 stddev:493.48 (10.3%) stddev-sans-first:471.34 12:06:36 INFO - 2015-11-06 12:06:36,119 DEBUG : BROWSER_OUTPUT: Values: 2703.0 2739.2 2752.8 2796.2 2796.9 4511.1 4622.8 4632.8 4644.6 4646.9 4482.1 4603.7 4618.2 4805.4 4830.3 4260.4 4274.6 4298.8 4361.6 4375.8 4302.9 4327.6 4333.7 4350.2 4369.3 4094.6 4179.4 4214.6 4309.8 4361.4 4070.0 4198.2 4221.4 4252.6 4288.8 4333.6 4335.0 4339.1 4343.4 4386.2 4407.7 4644.4 4657.8 4676.2 4762.0 4799.6 4832.0 4835.3 4849.8 4966.7 5019.4 5022.4 5047.2 5080.3 5113.0 4475.1 4722.2 4739.7 4743.2 4763.0 4880.8 4992.1 5012.1 5063.9 5125.1 4893.4 4921.8 4936.4 4992.7 5019.9 4838.6 4970.0 5011.9 5067.6 5069.5 4792.2 4819.3 4826.8 4940.2 4941.0 4966.4 4972.8 5010.7 5020.1 5067.8 3921.2 3925.7 3930.4 3955.4 3991.1 3375.1 3404.3 3487.3 3508.1 3580.4 4632.2 4646.8 4685.9 4687.3 4743.3 4973.1 5044.1 5044.1 5049.8 5052.7 4423.6 4463.4 4490.8 4554.6 4667.9 4342.0 4390.1 4393.0 4476.9 4490.8 5019.5 5029.6 5031.9 5086.2 5124.3 4837.4 4925.0 4928.6 4934.0 5037.9 4870.8 4974.5 5015.8 5037.6 5072.3 4893.6 4898.4 4940.8 4960.4 5001.7 4967.3 5007.9 5028.4 5041.7 5056.2 4632.1 4666.8 4773.4 4805.6 4859.9 4883.1 4932.7 4945.6 4958.0 5008.8 4787.1 4806.3 4879.0 4881.1 4892.9 4644.7 4738.9 4759.0 4808.2 4918.1 4745.1 4821.4 4842.7 4866.4 4917.8 12:06:36 INFO - 2015-11-06 12:06:36,119 DEBUG : BROWSER_OUTPUT: 12:06:36 INFO - 2015-11-06 12:06:36,121 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:38746.49 Median:28851.57 stddev:64391.49 (223.2%) stddev-sans-first:64507.98 12:06:36 INFO - 2015-11-06 12:06:36,121 DEBUG : BROWSER_OUTPUT: Values: 466.0 467.2 478.7 485.9 503.2 27190.6 27679.2 31690.4 32043.7 32150.0 35195.0 36018.3 36057.6 36159.3 36199.5 6965.6 7844.9 7897.9 8042.3 8043.0 4798.0 4805.0 4875.2 5256.3 7118.9 9107.1 9174.0 9195.6 9312.1 9461.6 5314.7 7193.0 7456.2 9106.4 9263.1 9143.5 9148.6 9304.3 9340.9 9380.5 32943.0 33518.3 33565.5 33602.7 33772.0 2540.6 2591.6 2617.1 2618.9 2679.4 23400.0 23865.3 23991.0 24195.0 24553.1 2087.2 2105.5 2129.4 2145.3 2241.4 234905.0 235010.0 235103.0 237292.0 238397.0 43176.0 51037.0 51747.2 51811.7 51818.0 40892.0 41181.4 53419.7 54449.7 54601.7 14080.7 14117.2 14131.8 14208.7 14249.0 10885.5 10922.3 10962.5 11029.0 11035.4 16486.3 16687.6 16711.3 16743.7 16811.6 7268.4 7437.2 7463.7 7464.8 7469.3 781.3 782.0 873.8 881.6 888.3 24288.1 24366.8 24427.5 24924.3 25136.2 927.3 930.5 934.0 997.5 1001.6 12280.6 12361.6 12413.4 12460.5 12839.6 267735.0 271496.0 275330.0 275346.0 276522.0 47583.8 47808.8 48170.3 48226.0 48386.0 1194.2 1198.8 1213.6 1216.5 1218.1 20745.9 24105.3 24647.5 24649.0 24666.3 38024.4 38429.0 38453.8 38543.8 38676.2 226124.0 227330.0 227452.0 227729.0 228422.0 22602.4 23016.2 23051.7 25537.4 25772.5 33817.8 33875.5 34685.0 34847.7 35314.5 26710.9 27156.3 27919.2 28062.3 28315.6 28170.6 28464.6 28589.4 29113.7 29321.9 29312.1 29337.0 29882.1 29883.7 30361.8 25216.7 26443.9 26622.7 26727.5 26926.0 20268.3 20533.0 20566.6 20602.5 20697.2 12:06:36 INFO - 2015-11-06 12:06:36,121 DEBUG : BROWSER_OUTPUT: 12:06:36 INFO - 2015-11-06 12:06:36,121 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:23956.80 Median:4665.39 stddev:79514.46 (1704.3%) stddev-sans-first:79717.66 12:06:36 INFO - 2015-11-06 12:06:36,125 DEBUG : BROWSER_OUTPUT: Values: 292.1 292.4 293.6 300.6 302.0 14407.4 14451.7 14551.1 14772.3 14943.9 14514.0 14534.0 15300.5 15343.0 15395.8 4497.2 4522.6 4634.6 4643.7 4701.6 4660.9 4661.0 4669.7 4670.2 4679.6 4527.0 4636.6 4637.4 4653.5 4690.1 4575.0 4598.8 4600.1 4610.8 4624.6 4035.1 4058.1 4059.9 4064.1 4072.5 17532.8 18159.9 18463.5 18503.4 18598.4 1645.7 1729.8 1780.1 1842.3 1907.8 10805.5 10980.6 11200.6 11248.7 11512.3 1405.2 1425.0 1425.4 1485.7 1490.9 41050.4 42267.0 44503.0 48614.5 49599.8 8147.4 8354.5 8394.7 8426.0 8483.1 9614.5 9698.7 9773.3 9928.7 10080.1 6909.5 7024.6 7035.5 7044.0 7044.9 7300.6 7330.9 7337.0 7339.4 7395.4 4935.9 5011.1 5019.3 5036.3 5038.8 1436.3 1438.2 1438.4 1441.3 1460.9 773.6 812.2 830.1 857.9 890.6 10078.7 10138.0 10209.8 15492.7 16159.4 350.7 398.1 407.2 415.2 419.8 5246.6 5453.2 5487.9 5576.3 5597.6 478380.0 484911.0 489437.0 490441.0 494035.0 35218.7 44470.0 48743.5 61857.0 63821.4 429.7 438.5 438.9 441.9 446.6 9379.4 9399.4 9413.0 9527.8 9560.3 29155.6 29458.4 29610.9 30089.8 30111.1 40917.0 41314.8 41322.8 41616.8 41781.8 4806.3 5213.5 5287.2 5289.2 5341.2 9746.8 9841.6 9956.5 9976.9 9976.9 8495.5 8519.7 8647.5 8768.0 8774.9 8385.6 8437.2 8445.5 8481.3 8593.5 8582.1 8684.7 8688.2 8782.0 8846.2 5213.1 5248.3 5256.5 5267.6 5270.7 8332.1 8447.7 8713.9 8763.7 8802.0 12:06:36 INFO - 2015-11-06 12:06:36,125 DEBUG : BROWSER_OUTPUT: 12:06:36 INFO - 2015-11-06 12:06:36,125 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4402.14 Median:5678.13 stddev:2211.76 (39.0%) stddev-sans-first:2203.99 12:06:36 INFO - 2015-11-06 12:06:36,125 DEBUG : BROWSER_OUTPUT: Values: 1093.8 1486.1 1553.7 1568.5 1576.9 5737.9 6110.8 6241.7 6319.8 6367.2 6221.7 6274.3 6330.2 6335.5 6345.4 1898.2 1920.3 1922.9 1928.9 1930.4 1841.2 1848.1 1854.8 1865.4 1873.9 1850.3 1872.0 1873.5 1874.2 1877.6 1815.8 1821.9 1830.9 1843.8 1853.4 1835.1 1848.6 1865.0 1871.5 1881.6 5628.2 6246.3 6260.0 6282.5 6285.5 3572.2 3808.4 3906.9 3954.4 3957.5 2419.7 2518.1 2548.6 2555.6 2559.9 770.3 794.8 795.4 805.4 827.2 8027.0 8177.5 8202.0 8206.8 8225.6 3389.3 3445.8 3492.3 3502.3 3533.8 6829.4 6830.7 6864.0 6872.4 6884.0 3940.0 3943.1 3944.9 3951.2 3970.8 3654.1 3663.2 3682.7 3689.7 3717.4 2744.5 2761.4 2789.0 2791.4 2795.9 811.5 817.5 825.1 838.4 838.9 900.5 943.9 1145.3 1159.5 1159.7 6014.5 6094.7 6112.8 6125.2 6139.5 900.8 910.4 928.2 1000.8 1018.6 4889.8 4905.7 4943.4 4950.4 4959.6 7083.6 7179.4 7300.7 7459.5 7486.8 7359.3 7400.7 7434.4 7446.7 7462.0 5887.6 5888.1 5978.8 6029.9 6030.8 5967.8 5972.9 5976.9 5983.4 5996.6 6627.9 6692.3 6833.3 6834.8 6848.5 6763.8 6871.2 6912.1 6932.4 6987.5 5164.7 5267.6 5290.9 5308.5 5315.9 5711.9 6107.5 6134.2 6140.8 6164.5 5492.3 5621.0 5691.9 5758.0 5797.9 5307.2 5506.3 5664.3 5697.0 5709.5 5709.1 5770.4 5796.1 5806.8 5839.8 5246.3 5301.8 5309.7 5327.8 5334.0 5034.7 5144.6 5155.7 5155.9 5354.5 12:06:36 INFO - 2015-11-06 12:06:36,125 DEBUG : BROWSER_OUTPUT: 12:06:36 INFO - 2015-11-06 12:06:36,125 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4605.14 Median:5348.90 stddev:1414.03 (26.4%) stddev-sans-first:1380.04 12:06:36 INFO - 2015-11-06 12:06:36,126 DEBUG : BROWSER_OUTPUT: Values: 269.7 279.8 280.9 282.3 288.6 5229.7 5238.1 5241.7 5247.1 5272.4 4990.7 5050.5 5115.1 5118.3 5140.4 3963.4 3978.2 3992.1 3996.8 4020.5 3983.7 4005.4 4007.1 4011.9 4017.5 3825.7 3889.0 3897.9 3987.8 3992.4 3947.0 3974.0 3994.3 4005.8 4017.6 3405.3 3408.8 3424.7 3424.9 3427.6 4939.1 5036.3 5066.1 5081.1 5120.8 4172.6 4294.0 4453.5 4457.0 4460.9 5342.2 5426.4 5437.7 5443.4 5475.0 3660.4 3686.2 3688.3 3694.5 3710.5 5632.8 5735.8 5738.5 5749.5 5756.8 3621.8 3711.8 3729.2 3733.3 3746.8 3787.3 3828.1 3833.5 3840.8 3860.0 4463.5 4487.5 4488.2 4488.9 4500.1 5518.1 5539.4 5540.9 5557.4 5559.3 1369.7 1377.5 1382.8 1391.2 1397.4 875.8 882.2 897.7 899.4 901.9 5319.3 5332.9 5365.7 5376.2 5387.7 5737.6 5745.8 5750.7 5764.2 5786.0 5326.9 5339.3 5346.5 5351.3 5364.0 3076.8 3150.2 3175.7 3195.9 3196.7 5772.6 5799.7 5828.4 5828.5 5840.8 5869.0 5888.7 5900.4 5921.7 5929.1 5436.6 5609.9 5826.4 5835.0 5838.6 5686.7 5713.9 5738.2 5742.2 5771.9 5623.3 5640.4 5641.1 5665.7 5682.9 5766.0 5772.8 5784.4 5828.7 5839.1 3697.8 3778.4 3783.5 3824.7 3827.0 5801.6 5817.0 5833.9 5835.5 5858.3 5612.9 5623.0 5624.1 5636.4 5648.6 5465.7 5588.6 5591.8 5622.2 5653.2 5497.7 5502.3 5502.5 5510.5 5518.0 5679.3 5687.3 5692.4 5701.7 5705.7 5501.5 5502.7 5521.6 5522.3 5528.8 12:06:36 INFO - 2015-11-06 12:06:36,126 DEBUG : BROWSER_OUTPUT: 12:06:36 INFO - 2015-11-06 12:06:36,126 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11756.22 Median:597.96 stddev:13966.82 (2335.8%) stddev-sans-first:13980.89 12:06:36 INFO - 2015-11-06 12:06:36,127 DEBUG : BROWSER_OUTPUT: Values: 603.8 642.7 657.2 680.8 690.3 12092.8 12325.5 12343.7 12345.4 12374.3 11452.0 11498.2 11552.1 11599.8 11782.1 615.1 617.1 621.1 744.3 765.6 764.0 771.0 778.9 779.6 784.4 809.2 810.1 812.9 814.1 814.6 645.4 659.9 796.7 804.6 819.9 597.7 598.2 601.6 607.7 608.4 11818.3 11983.3 12008.9 12037.5 12122.0 10097.1 10128.0 10558.2 10822.4 10857.1 7920.2 8229.9 8279.2 8508.1 8660.6 2834.6 2889.8 2903.1 2942.6 2952.0 42622.6 42857.0 43061.0 43072.0 43806.6 7909.9 7913.3 7969.4 7996.4 8049.7 17089.0 17102.4 17250.1 17264.1 17365.0 5982.9 6200.8 6225.5 6312.0 6366.6 3348.6 3428.4 3438.9 3454.3 3462.0 2458.7 2565.9 2566.2 2570.4 2571.5 364.4 367.4 372.3 373.1 380.3 482.7 501.7 506.3 515.4 532.8 6324.4 6960.4 7386.6 7440.8 7702.0 457.6 462.6 516.0 523.4 547.3 3210.6 3220.4 3239.4 3272.9 3339.4 48858.0 48872.3 49403.5 49543.5 49761.0 41961.8 43132.0 43247.4 43341.8 43350.0 39741.2 41178.4 41413.4 41450.6 42253.6 6671.4 6728.2 7119.8 7146.9 7170.0 28747.1 28873.7 29049.1 29502.0 29553.6 37385.4 37535.0 41787.8 41993.8 42015.6 6552.1 6579.0 6585.0 6698.4 6789.9 9553.4 9614.1 9629.8 9644.1 9689.0 8940.2 8965.7 8987.4 9211.8 9254.8 9060.9 9256.0 9275.0 9287.3 9437.1 8935.7 9091.4 9236.9 9307.4 9330.2 7575.0 7645.0 7787.0 8080.6 8192.4 7591.2 7633.7 7691.8 7711.5 7993.6 12:06:36 INFO - 2015-11-06 12:06:36,129 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:06:36 INFO - 2015-11-06 12:06:36,129 DEBUG : BROWSER_OUTPUT: 12:06:36 INFO - 2015-11-06 12:06:36,790 INFO : Browser exited with error code: 0 12:06:36 INFO - 2015-11-06 12:06:36,823 INFO : Completed test dromaeo_css (00:18:34) 12:06:36 INFO - 2015-11-06 12:06:36,823 INFO : Starting test kraken 12:06:36 INFO - 2015-11-06 12:06:36,823 DEBUG : operating with platform_type : mac_ 12:06:36 INFO - 2015-11-06 12:06:36,823 INFO : Initialising browser for kraken test... 12:06:36 INFO - 2015-11-06 12:06:36,839 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/tmpWJxTcQ/profile http://localhost:50024/getInfo.html 12:06:39 INFO - 2015-11-06 12:06:39,246 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:06:39 INFO - 2015-11-06 12:06:39,246 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:06:39 INFO - 2015-11-06 12:06:39,246 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 12:06:39 INFO - 2015-11-06 12:06:39,247 DEBUG : BROWSER_OUTPUT: __metrics 12:06:39 INFO - 2015-11-06 12:06:39,262 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:06:40 INFO - 2015-11-06 12:06:40,017 INFO : Browser initialized. 12:06:40 INFO - 2015-11-06 12:06:40,017 INFO : Running cycle 1/1 for kraken test... 12:06:40 INFO - 2015-11-06 12:06:40,018 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/tmpWJxTcQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:06:52 INFO - 2015-11-06 12:06:52,053 DEBUG : BROWSER_OUTPUT: RSS: Main: 222502912 12:06:52 INFO - 2015-11-06 12:06:52,053 DEBUG : BROWSER_OUTPUT: 12:06:54 INFO - 2015-11-06 12:06:54,824 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50024/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50024/tests/kraken/driver.html?testName=audio-beat-detection) 12:06:55 INFO - 2015-11-06 12:06:55,418 DEBUG : BROWSER_OUTPUT: RSS: Main: 277942272 12:06:55 INFO - 2015-11-06 12:06:55,418 DEBUG : BROWSER_OUTPUT: 12:06:58 INFO - 2015-11-06 12:06:58,366 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50024/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50024/tests/kraken/driver.html?testName=audio-dft) 12:06:58 INFO - 2015-11-06 12:06:58,953 DEBUG : BROWSER_OUTPUT: RSS: Main: 290582528 12:06:58 INFO - 2015-11-06 12:06:58,953 DEBUG : BROWSER_OUTPUT: 12:07:02 INFO - 2015-11-06 12:07:02,227 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50024/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50024/tests/kraken/driver.html?testName=audio-fft) 12:07:02 INFO - 2015-11-06 12:07:02,800 DEBUG : BROWSER_OUTPUT: RSS: Main: 273760256 12:07:02 INFO - 2015-11-06 12:07:02,800 DEBUG : BROWSER_OUTPUT: 12:07:05 INFO - 2015-11-06 12:07:05,003 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50024/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50024/tests/kraken/driver.html?testName=audio-oscillator) 12:07:05 INFO - 2015-11-06 12:07:05,590 DEBUG : BROWSER_OUTPUT: RSS: Main: 273920000 12:07:05 INFO - 2015-11-06 12:07:05,590 DEBUG : BROWSER_OUTPUT: 12:07:08 INFO - 2015-11-06 12:07:08,011 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50024/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50024/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:07:08 INFO - 2015-11-06 12:07:08,585 DEBUG : BROWSER_OUTPUT: RSS: Main: 276246528 12:07:08 INFO - 2015-11-06 12:07:08,586 DEBUG : BROWSER_OUTPUT: 12:07:12 INFO - 2015-11-06 12:07:12,023 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50024/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50024/tests/kraken/driver.html?testName=imaging-darkroom) 12:07:12 INFO - 2015-11-06 12:07:12,607 DEBUG : BROWSER_OUTPUT: RSS: Main: 276668416 12:07:12 INFO - 2015-11-06 12:07:12,607 DEBUG : BROWSER_OUTPUT: 12:07:16 INFO - 2015-11-06 12:07:16,125 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50024/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50024/tests/kraken/driver.html?testName=imaging-desaturate) 12:07:16 INFO - 2015-11-06 12:07:16,706 DEBUG : BROWSER_OUTPUT: RSS: Main: 271044608 12:07:16 INFO - 2015-11-06 12:07:16,706 DEBUG : BROWSER_OUTPUT: 12:07:19 INFO - 2015-11-06 12:07:19,951 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50024/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50024/tests/kraken/driver.html?testName=json-parse-financial) 12:07:20 INFO - 2015-11-06 12:07:20,526 DEBUG : BROWSER_OUTPUT: RSS: Main: 273833984 12:07:20 INFO - 2015-11-06 12:07:20,526 DEBUG : BROWSER_OUTPUT: 12:07:22 INFO - 2015-11-06 12:07:22,210 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50024/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50024/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:07:22 INFO - 2015-11-06 12:07:22,777 DEBUG : BROWSER_OUTPUT: RSS: Main: 308838400 12:07:22 INFO - 2015-11-06 12:07:22,777 DEBUG : BROWSER_OUTPUT: 12:07:24 INFO - 2015-11-06 12:07:24,742 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50024/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50024/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:07:25 INFO - 2015-11-06 12:07:25,368 DEBUG : BROWSER_OUTPUT: RSS: Main: 308723712 12:07:25 INFO - 2015-11-06 12:07:25,368 DEBUG : BROWSER_OUTPUT: 12:07:27 INFO - 2015-11-06 12:07:27,678 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50024/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50024/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:07:28 INFO - 2015-11-06 12:07:28,263 DEBUG : BROWSER_OUTPUT: RSS: Main: 317415424 12:07:28 INFO - 2015-11-06 12:07:28,263 DEBUG : BROWSER_OUTPUT: 12:07:31 INFO - 2015-11-06 12:07:31,160 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50024/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50024/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:07:31 INFO - 2015-11-06 12:07:31,753 DEBUG : BROWSER_OUTPUT: RSS: Main: 319733760 12:07:31 INFO - 2015-11-06 12:07:31,753 DEBUG : BROWSER_OUTPUT: 12:07:34 INFO - 2015-11-06 12:07:34,661 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50024/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50024/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:07:35 INFO - 2015-11-06 12:07:35,235 DEBUG : BROWSER_OUTPUT: RSS: Main: 318517248 12:07:35 INFO - 2015-11-06 12:07:35,236 DEBUG : BROWSER_OUTPUT: 12:07:37 INFO - 2015-11-06 12:07:37,127 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50024/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50024/tests/kraken/driver.html?testName=ai-astar) 12:07:37 INFO - 2015-11-06 12:07:37,373 DEBUG : BROWSER_OUTPUT: RSS: Main: 377360384 12:07:37 INFO - 2015-11-06 12:07:37,373 DEBUG : BROWSER_OUTPUT: 12:07:37 INFO - 2015-11-06 12:07:37,374 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:07:37 INFO - 2015-11-06 12:07:37,374 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:07:37 INFO - 2015-11-06 12:07:37,375 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:07:37 INFO - 2015-11-06 12:07:37,375 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:07:37 INFO - 2015-11-06 12:07:37,375 DEBUG : BROWSER_OUTPUT: |0;ai-astar;123;125;120;128;127;122;123;121;117;126 12:07:37 INFO - 2015-11-06 12:07:37,375 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;179;151;180;190;147;173;175;147;188;149 12:07:37 INFO - 2015-11-06 12:07:37,375 DEBUG : BROWSER_OUTPUT: |2;audio-dft;181;187;188;188;183;183;187;187;184;183 12:07:37 INFO - 2015-11-06 12:07:37,375 DEBUG : BROWSER_OUTPUT: |3;audio-fft;86;86;100;99;99;80;82;95;94;80 12:07:37 INFO - 2015-11-06 12:07:37,376 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;108;108;160;105;104;104;152;105;104;157 12:07:37 INFO - 2015-11-06 12:07:37,376 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;127;132;142;142;135;142;139;136;142;141 12:07:37 INFO - 2015-11-06 12:07:37,376 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;148;147;140;147;147;147;146;141 12:07:37 INFO - 2015-11-06 12:07:37,376 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;119;118;119;120;118;124;123;119;118;118 12:07:37 INFO - 2015-11-06 12:07:37,376 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;63;65;66;67;66;66;67;77;65;65 12:07:37 INFO - 2015-11-06 12:07:37,376 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;74;73;74;76;78;78;78;77;78;78 12:07:37 INFO - 2015-11-06 12:07:37,377 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;94;99;100;101;102;101;101;101;104;102 12:07:37 INFO - 2015-11-06 12:07:37,377 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;143;156;154;148;149;142;147;142;155;154 12:07:37 INFO - 2015-11-06 12:07:37,377 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;167;175;177;173;175;176;176;176;173;166 12:07:37 INFO - 2015-11-06 12:07:37,377 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;77;79;83;81;82;81;80;81;84;82 12:07:37 INFO - 2015-11-06 12:07:37,377 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:07:37 INFO - 2015-11-06 12:07:37,377 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:07:37 INFO - 2015-11-06 12:07:37,378 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,945 12:07:37 INFO - 2015-11-06 12:07:37,378 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:07:37 INFO - 2015-11-06 12:07:37,378 DEBUG : BROWSER_OUTPUT: __startTimestamp1446840457373__endTimestamp 12:07:37 INFO - 2015-11-06 12:07:37,378 DEBUG : BROWSER_OUTPUT: 12:07:37 INFO - 2015-11-06 12:07:37,379 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:07:37 INFO - 2015-11-06 12:07:37,380 DEBUG : BROWSER_OUTPUT: Number of tests: 14 12:07:37 INFO - 2015-11-06 12:07:37,380 DEBUG : BROWSER_OUTPUT: 12:07:37 INFO - 2015-11-06 12:07:37,380 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:123.20 Median:124.00 stddev:3.39 (2.7%) stddev-sans-first:3.60 12:07:37 INFO - 2015-11-06 12:07:37,380 DEBUG : BROWSER_OUTPUT: Values: 123.0 125.0 120.0 128.0 127.0 122.0 123.0 121.0 117.0 126.0 12:07:37 INFO - 2015-11-06 12:07:37,380 DEBUG : BROWSER_OUTPUT: 12:07:37 INFO - 2015-11-06 12:07:37,380 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:167.90 Median:177.00 stddev:17.50 (9.9%) stddev-sans-first:18.09 12:07:37 INFO - 2015-11-06 12:07:37,381 DEBUG : BROWSER_OUTPUT: Values: 179.0 151.0 180.0 190.0 147.0 173.0 175.0 147.0 188.0 149.0 12:07:37 INFO - 2015-11-06 12:07:37,381 DEBUG : BROWSER_OUTPUT: 12:07:37 INFO - 2015-11-06 12:07:37,381 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:185.10 Median:187.00 stddev:2.56 (1.4%) stddev-sans-first:2.24 12:07:37 INFO - 2015-11-06 12:07:37,381 DEBUG : BROWSER_OUTPUT: Values: 181.0 187.0 188.0 188.0 183.0 183.0 187.0 187.0 184.0 183.0 12:07:37 INFO - 2015-11-06 12:07:37,381 DEBUG : BROWSER_OUTPUT: 12:07:37 INFO - 2015-11-06 12:07:37,381 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:90.10 Median:90.00 stddev:8.16 (9.1%) stddev-sans-first:8.52 12:07:37 INFO - 2015-11-06 12:07:37,382 DEBUG : BROWSER_OUTPUT: Values: 86.0 86.0 100.0 99.0 99.0 80.0 82.0 95.0 94.0 80.0 12:07:37 INFO - 2015-11-06 12:07:37,382 DEBUG : BROWSER_OUTPUT: 12:07:37 INFO - 2015-11-06 12:07:37,382 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:120.70 Median:108.00 stddev:24.71 (22.9%) stddev-sans-first:25.78 12:07:37 INFO - 2015-11-06 12:07:37,382 DEBUG : BROWSER_OUTPUT: Values: 108.0 108.0 160.0 105.0 104.0 104.0 152.0 105.0 104.0 157.0 12:07:37 INFO - 2015-11-06 12:07:37,382 DEBUG : BROWSER_OUTPUT: 12:07:37 INFO - 2015-11-06 12:07:37,382 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:137.80 Median:141.50 stddev:5.20 (3.7%) stddev-sans-first:3.77 12:07:37 INFO - 2015-11-06 12:07:37,383 DEBUG : BROWSER_OUTPUT: Values: 127.0 132.0 142.0 142.0 135.0 142.0 139.0 136.0 142.0 141.0 12:07:37 INFO - 2015-11-06 12:07:37,383 DEBUG : BROWSER_OUTPUT: 12:07:37 INFO - 2015-11-06 12:07:37,384 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.80 Median:147.00 stddev:2.86 (1.9%) stddev-sans-first:2.92 12:07:37 INFO - 2015-11-06 12:07:37,384 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 148.0 147.0 140.0 147.0 147.0 147.0 146.0 141.0 12:07:37 INFO - 2015-11-06 12:07:37,384 DEBUG : BROWSER_OUTPUT: 12:07:37 INFO - 2015-11-06 12:07:37,385 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:119.60 Median:119.00 stddev:2.17 (1.8%) stddev-sans-first:2.29 12:07:37 INFO - 2015-11-06 12:07:37,385 DEBUG : BROWSER_OUTPUT: Values: 119.0 118.0 119.0 120.0 118.0 124.0 123.0 119.0 118.0 118.0 12:07:37 INFO - 2015-11-06 12:07:37,385 DEBUG : BROWSER_OUTPUT: 12:07:37 INFO - 2015-11-06 12:07:37,385 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:66.70 Median:66.00 stddev:3.80 (5.8%) stddev-sans-first:3.79 12:07:37 INFO - 2015-11-06 12:07:37,385 DEBUG : BROWSER_OUTPUT: Values: 63.0 65.0 66.0 67.0 66.0 66.0 67.0 77.0 65.0 65.0 12:07:37 INFO - 2015-11-06 12:07:37,385 DEBUG : BROWSER_OUTPUT: 12:07:37 INFO - 2015-11-06 12:07:37,385 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:76.40 Median:78.00 stddev:2.01 (2.6%) stddev-sans-first:1.94 12:07:37 INFO - 2015-11-06 12:07:37,385 DEBUG : BROWSER_OUTPUT: Values: 74.0 73.0 74.0 76.0 78.0 78.0 78.0 77.0 78.0 78.0 12:07:37 INFO - 2015-11-06 12:07:37,385 DEBUG : BROWSER_OUTPUT: 12:07:37 INFO - 2015-11-06 12:07:37,385 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:100.50 Median:102.00 stddev:2.64 (2.6%) stddev-sans-first:1.39 12:07:37 INFO - 2015-11-06 12:07:37,385 DEBUG : BROWSER_OUTPUT: Values: 94.0 99.0 100.0 101.0 102.0 101.0 101.0 101.0 104.0 102.0 12:07:37 INFO - 2015-11-06 12:07:37,385 DEBUG : BROWSER_OUTPUT: 12:07:37 INFO - 2015-11-06 12:07:37,385 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:149.00 Median:151.50 stddev:5.52 (3.6%) stddev-sans-first:5.41 12:07:37 INFO - 2015-11-06 12:07:37,386 DEBUG : BROWSER_OUTPUT: Values: 143.0 156.0 154.0 148.0 149.0 142.0 147.0 142.0 155.0 154.0 12:07:37 INFO - 2015-11-06 12:07:37,386 DEBUG : BROWSER_OUTPUT: 12:07:37 INFO - 2015-11-06 12:07:37,386 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.40 Median:175.50 stddev:3.86 (2.2%) stddev-sans-first:3.33 12:07:37 INFO - 2015-11-06 12:07:37,386 DEBUG : BROWSER_OUTPUT: Values: 167.0 175.0 177.0 173.0 175.0 176.0 176.0 176.0 173.0 166.0 12:07:37 INFO - 2015-11-06 12:07:37,386 DEBUG : BROWSER_OUTPUT: 12:07:37 INFO - 2015-11-06 12:07:37,386 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:81.00 Median:81.50 stddev:2.00 (2.5%) stddev-sans-first:1.51 12:07:37 INFO - 2015-11-06 12:07:37,386 DEBUG : BROWSER_OUTPUT: Values: 77.0 79.0 83.0 81.0 82.0 81.0 80.0 81.0 84.0 82.0 12:07:37 INFO - 2015-11-06 12:07:37,386 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:07:37 INFO - 2015-11-06 12:07:37,386 DEBUG : BROWSER_OUTPUT: 12:07:38 INFO - 2015-11-06 12:07:38,135 INFO : Browser exited with error code: 0 12:07:38 INFO - 2015-11-06 12:07:38,190 INFO : Completed test kraken (00:01:01) 12:07:38 INFO - 2015-11-06 12:07:38,190 INFO : Starting test v8_7 12:07:38 INFO - 2015-11-06 12:07:38,190 DEBUG : operating with platform_type : mac_ 12:07:38 INFO - 2015-11-06 12:07:38,190 INFO : Initialising browser for v8_7 test... 12:07:38 INFO - 2015-11-06 12:07:38,204 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/tmp_tdn3V/profile http://localhost:50024/getInfo.html 12:07:40 INFO - 2015-11-06 12:07:40,592 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:07:40 INFO - 2015-11-06 12:07:40,594 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:07:40 INFO - 2015-11-06 12:07:40,594 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 12:07:40 INFO - 2015-11-06 12:07:40,594 DEBUG : BROWSER_OUTPUT: __metrics 12:07:40 INFO - 2015-11-06 12:07:40,614 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:07:41 INFO - 2015-11-06 12:07:41,393 INFO : Browser initialized. 12:07:41 INFO - 2015-11-06 12:07:41,394 INFO : Running cycle 1/1 for v8_7 test... 12:07:41 INFO - 2015-11-06 12:07:41,394 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/tmp_tdn3V/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:07:53 INFO - 2015-11-06 12:07:53,393 DEBUG : BROWSER_OUTPUT: RSS: Main: 221757440 12:07:53 INFO - 2015-11-06 12:07:53,393 DEBUG : BROWSER_OUTPUT: 12:08:16 INFO - 2015-11-06 12:08:16,300 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50024/tests/v8_7/run.html (next: http://localhost:50024/tests/v8_7/run.html) 12:08:16 INFO - 2015-11-06 12:08:16,551 DEBUG : BROWSER_OUTPUT: RSS: Main: 674873344 12:08:16 INFO - 2015-11-06 12:08:16,551 DEBUG : BROWSER_OUTPUT: 12:08:16 INFO - 2015-11-06 12:08:16,552 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:08:16 INFO - 2015-11-06 12:08:16,552 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:08:16 INFO - 2015-11-06 12:08:16,552 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:08:16 INFO - 2015-11-06 12:08:16,552 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:08:16 INFO - 2015-11-06 12:08:16,552 DEBUG : BROWSER_OUTPUT: |0;Richards;190.4036557501904 12:08:16 INFO - 2015-11-06 12:08:16,552 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;222.17285047767163 12:08:16 INFO - 2015-11-06 12:08:16,552 DEBUG : BROWSER_OUTPUT: |2;Encrypt;361.53289949385396 12:08:16 INFO - 2015-11-06 12:08:16,552 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6924.137931034483 12:08:16 INFO - 2015-11-06 12:08:16,552 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2364.066193853428 12:08:16 INFO - 2015-11-06 12:08:16,552 DEBUG : BROWSER_OUTPUT: |5;Earley;1033.0578512396694 12:08:16 INFO - 2015-11-06 12:08:16,552 DEBUG : BROWSER_OUTPUT: |6;Boyer;14400 12:08:16 INFO - 2015-11-06 12:08:16,552 DEBUG : BROWSER_OUTPUT: |7;RegExp;33866.666666666664 12:08:16 INFO - 2015-11-06 12:08:16,553 DEBUG : BROWSER_OUTPUT: |8;Splay;707.7140835102618 12:08:16 INFO - 2015-11-06 12:08:16,553 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6622.516556291391 12:08:16 INFO - 2015-11-06 12:08:16,553 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:08:16 INFO - 2015-11-06 12:08:16,553 DEBUG : BROWSER_OUTPUT: __startTimestamp1446840496548__endTimestamp 12:08:16 INFO - 2015-11-06 12:08:16,553 DEBUG : BROWSER_OUTPUT: 12:08:16 INFO - 2015-11-06 12:08:16,553 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:08:16 INFO - 2015-11-06 12:08:16,553 DEBUG : BROWSER_OUTPUT: Number of tests: 10 12:08:16 INFO - 2015-11-06 12:08:16,553 DEBUG : BROWSER_OUTPUT: 12:08:16 INFO - 2015-11-06 12:08:16,554 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:190.40 Median:190.40 stddev:0.00 (0.0%) 12:08:16 INFO - 2015-11-06 12:08:16,554 DEBUG : BROWSER_OUTPUT: Values: 190.4 12:08:16 INFO - 2015-11-06 12:08:16,554 DEBUG : BROWSER_OUTPUT: 12:08:16 INFO - 2015-11-06 12:08:16,554 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:222.17 Median:222.17 stddev:0.00 (0.0%) 12:08:16 INFO - 2015-11-06 12:08:16,554 DEBUG : BROWSER_OUTPUT: Values: 222.2 12:08:16 INFO - 2015-11-06 12:08:16,554 DEBUG : BROWSER_OUTPUT: 12:08:16 INFO - 2015-11-06 12:08:16,554 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:361.53 Median:361.53 stddev:0.00 (0.0%) 12:08:16 INFO - 2015-11-06 12:08:16,554 DEBUG : BROWSER_OUTPUT: Values: 361.5 12:08:16 INFO - 2015-11-06 12:08:16,554 DEBUG : BROWSER_OUTPUT: 12:08:16 INFO - 2015-11-06 12:08:16,555 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6924.14 Median:6924.14 stddev:0.00 (0.0%) 12:08:16 INFO - 2015-11-06 12:08:16,555 DEBUG : BROWSER_OUTPUT: Values: 6924.1 12:08:16 INFO - 2015-11-06 12:08:16,555 DEBUG : BROWSER_OUTPUT: 12:08:16 INFO - 2015-11-06 12:08:16,555 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2364.07 Median:2364.07 stddev:0.00 (0.0%) 12:08:16 INFO - 2015-11-06 12:08:16,555 DEBUG : BROWSER_OUTPUT: Values: 2364.1 12:08:16 INFO - 2015-11-06 12:08:16,555 DEBUG : BROWSER_OUTPUT: 12:08:16 INFO - 2015-11-06 12:08:16,555 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:1033.06 Median:1033.06 stddev:0.00 (0.0%) 12:08:16 INFO - 2015-11-06 12:08:16,555 DEBUG : BROWSER_OUTPUT: Values: 1033.1 12:08:16 INFO - 2015-11-06 12:08:16,555 DEBUG : BROWSER_OUTPUT: 12:08:16 INFO - 2015-11-06 12:08:16,556 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:14400.00 Median:14400.00 stddev:0.00 (0.0%) 12:08:16 INFO - 2015-11-06 12:08:16,556 DEBUG : BROWSER_OUTPUT: Values: 14400.0 12:08:16 INFO - 2015-11-06 12:08:16,556 DEBUG : BROWSER_OUTPUT: 12:08:16 INFO - 2015-11-06 12:08:16,556 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:33866.67 Median:33866.67 stddev:0.00 (0.0%) 12:08:16 INFO - 2015-11-06 12:08:16,556 DEBUG : BROWSER_OUTPUT: Values: 33866.7 12:08:16 INFO - 2015-11-06 12:08:16,556 DEBUG : BROWSER_OUTPUT: 12:08:16 INFO - 2015-11-06 12:08:16,556 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:707.71 Median:707.71 stddev:0.00 (0.0%) 12:08:16 INFO - 2015-11-06 12:08:16,556 DEBUG : BROWSER_OUTPUT: Values: 707.7 12:08:16 INFO - 2015-11-06 12:08:16,556 DEBUG : BROWSER_OUTPUT: 12:08:16 INFO - 2015-11-06 12:08:16,557 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6622.52 Median:6622.52 stddev:0.00 (0.0%) 12:08:16 INFO - 2015-11-06 12:08:16,557 DEBUG : BROWSER_OUTPUT: Values: 6622.5 12:08:16 INFO - 2015-11-06 12:08:16,557 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:08:16 INFO - 2015-11-06 12:08:16,557 DEBUG : BROWSER_OUTPUT: 12:08:17 INFO - 2015-11-06 12:08:17,314 INFO : Browser exited with error code: 0 12:08:17 INFO - 2015-11-06 12:08:17,338 INFO : Completed test v8_7 (00:00:39) 12:08:17 INFO - 2015-11-06 12:08:17,750 INFO : Completed test suite (00:20:15) 12:08:17 INFO - 2015-11-06 12:08:17,750 DEBUG : Working with test: dromaeo_css 12:08:17 INFO - 2015-11-06 12:08:17,750 DEBUG : Generating results file: dromaeo_css 12:08:17 INFO - 2015-11-06 12:08:17,751 DEBUG : Working with test: kraken 12:08:17 INFO - 2015-11-06 12:08:17,751 DEBUG : Generating results file: kraken 12:08:17 INFO - 2015-11-06 12:08:17,751 INFO : javascript benchmark 12:08:17 INFO - 2015-11-06 12:08:17,751 DEBUG : Working with test: v8_7 12:08:17 INFO - 2015-11-06 12:08:17,751 DEBUG : Generating results file: v8_7 12:08:17 INFO - 2015-11-06 12:08:17,751 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:08:17 INFO - 2015-11-06 12:08:17,807 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,55]] 12:08:17 INFO - 2015-11-06 12:08:17,807 DEBUG : process_Request line: dromaeo_css 5779.75 graph.html#tests=[[72,64,55]] 12:08:17 INFO - 2015-11-06 12:08:17,807 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:08:17 INFO - 2015-11-06 12:08:17,835 DEBUG : process_Request line: kraken 1737.20 graph.html#tests=[[232,64,55]] 12:08:17 INFO - 2015-11-06 12:08:17,835 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:08:17 INFO - 2015-11-06 12:08:17,864 DEBUG : process_Request line: v8_7 15947.39 graph.html#tests=[[230,64,55]] 12:08:17 INFO - 2015-11-06 12:08:17,865 INFO : javascript benchmark 12:08:17 INFO - 2015-11-06 12:08:17,867 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [292.1119795820705, 292.35243934684667, 293.55233269264374, 300.64073432248466, 302.00489387468303, 14407.423703051878, 14451.710965780705, 14551.05418147821, 14772.261386930637, 14943.925280373596, 14514.0, 14534.0, 15300.464483743071, 15343.0, 15395.846041539582, 4497.190505708971, 4522.592966632994, 4634.629229661636, 4643.698159619631, 4701.576858082772, 4660.86017419478, 4661.044485880403, 4669.743164125972, 4670.182718024332, 4679.625629949613, 4527.049319642879, 4636.629069674418, 4637.397138372007, 4653.534646535353, 4690.0854333405, 4575.0, 4598.816047358118, 4600.102979918884, 4610.792514336863, 4624.606908412772, 4035.1324465240114, 4058.1275025869286, 4059.939100913489, 4064.065264989069, 4072.4705788247634, 17532.824671753246, 18159.909200454047, 18463.538411539685, 18503.352382666675, 18598.44204673862, 1645.7449095390234, 1729.7751292332043, 1780.1455301455374, 1842.2907180735378, 1907.761529808774, 10805.513751881106, 10980.560777568888, 11200.607978720705, 11248.662540123809, 11512.251703639236, 1405.1779708870222, 1424.950126745559, 1425.4013314407973, 1485.6880055188424, 1490.941431583566, 41050.38424423636, 42266.999999999694, 44503.0, 48614.513854861354, 49599.75200124012, 8147.388945829087, 8354.498730076215, 8394.706185283485, 8425.95787021061, 8483.066862645104, 9614.51927403627, 9698.70903872885, 9773.267004974656, 9928.702138935843, 10080.143187829117, 6909.481788865754, 7024.613646249403, 7035.507514473938, 7043.964780176067, 7044.894326585106, 7300.56196628204, 7330.8900366494545, 7337.046183996046, 7339.412846972336, 7395.371393431511, 4935.8519244422005, 5011.09800235961, 5019.322391477177, 5036.345275114211, 5038.84883453497, 1436.2746812859648, 1438.2089850582138, 1438.3671184678708, 1441.3081720774087, 1460.8685218330402, 773.5629369406267, 812.1504070704934, 830.1449507007792, 857.9313654907593, 890.643742503004, 10078.697639070839, 10138.0, 10209.795804083877, 15492.690146197237, 16159.43441979525, 350.7124158190259, 398.07646260674954, 407.20391634355354, 415.19866657350997, 419.7628339987958, 5246.554042906319, 5453.157813349505, 5487.945120548743, 5576.330840299109, 5597.580181486404, 478380.0, 484911.0, 489437.0, 490441.0, 494035.0, 35218.71719242134, 44470.0, 48743.5125648746, 61857.0, 63821.361786381545, 429.7035045818438, 438.537343103023, 438.8815019944661, 441.8873187337273, 446.6181414890287, 9379.390339627902, 9399.436033837992, 9412.95293523528, 9527.809443811224, 9560.330776845554, 29155.562666560443, 29458.410831783673, 29610.851945740134, 30089.796408144306, 30111.09666710002, 40917.0, 41314.79342603268, 41322.79338603288, 41616.79191604144, 41781.79109104557, 4806.279058141306, 5213.530782229617, 5287.154055351125, 5289.20661900718, 5341.198820177005, 9746.80506389854, 9841.557129929028, 9956.452395118338, 9976.850347244943, 9976.900230997888, 8495.490270583785, 8519.659213631385, 8647.481151130953, 8768.0, 8774.912250877665, 8385.622646981023, 8437.240648341678, 8445.451045682012, 8481.27909127731, 8593.52735599523, 8582.141785821368, 8684.696035638723, 8688.218060374596, 8781.956090219508, 8846.248068914214, 5213.061648903082, 5248.343957005374, 5256.4743525648655, 5267.631265811357, 5270.657407268515, 8332.125126861592, 8447.704330348408, 8713.91286087131, 8763.693270735494, 8801.955990220007], "dojo.html": [2702.9864850675744, 2739.1919383781783, 2752.8348299102054, 2796.2456979874833, 2796.8601569921498, 4511.120331535352, 4622.838200662977, 4632.814687412504, 4644.5819876211135, 4646.883827904304, 4482.1035792841485, 4603.7237765734, 4618.214903466419, 4805.351277577526, 4830.2754586812, 4260.42484264625, 4274.615284624383, 4298.763568003758, 4361.60745532902, 4375.803088860993, 4302.892427689317, 4327.610515053644, 4333.65330773539, 4350.15172041452, 4369.279068953619, 4094.5700701426517, 4179.373094035888, 4214.557471465482, 4309.762963037032, 4361.43301370823, 4069.97965010176, 4198.223328684173, 4221.409002739619, 4252.574742525722, 4288.849890253826, 4333.566643335641, 4335.0, 4339.110482351142, 4343.413639158704, 4386.166628340605, 4407.735535867858, 4644.442666879962, 4657.790399432034, 4676.205045142334, 4762.047590481918, 4799.6400269979895, 4832.0, 4835.2505361669, 4849.806007759686, 4966.726830024347, 5019.397672279313, 5022.397312322508, 5047.167217409123, 5080.288759573663, 5113.002964421939, 4475.1049790042125, 4722.197226471508, 4739.691920025188, 4743.217369134089, 4762.976185119052, 4880.829170978998, 4992.101421744048, 5012.097822391932, 5063.87340316495, 5125.051865404837, 4893.437254715682, 4921.803127874845, 4936.432310284292, 4992.700437973734, 5019.874503137451, 4838.637102217348, 4969.950300497021, 5011.924821127686, 5067.569256613156, 5069.467705890902, 4792.185328494094, 4819.2530157825595, 4826.8069277228515, 4940.184869496565, 4941.036497882878, 4966.379202599675, 4972.7513624318635, 5010.674306170087, 5020.096382651158, 5067.771950262247, 3921.2353591049473, 3925.666318362914, 3930.449737036817, 3955.4462375267485, 3991.1419044904906, 3375.1224681582967, 3404.268082362304, 3487.3199726053176, 3508.052825737088, 3580.373434648926, 4632.189366860786, 4646.8141274348645, 4685.906281874343, 4687.343771871941, 4743.312219728189, 4973.079980203674, 5044.117279476077, 5044.142495775727, 5049.772760225798, 5052.671576347526, 4423.646108311327, 4463.375127482155, 4490.7754612269255, 4554.63562914966, 4667.906641867212, 4342.0, 4390.121975604892, 4393.0, 4476.903158726133, 4490.820367185342, 5019.52314530119, 5029.597632189416, 5031.924521132186, 5086.186210206423, 5124.30821839047, 4837.395325584302, 4925.014997000542, 4928.6057115431395, 4934.01319736047, 5037.949620503748, 4870.829520966749, 4974.502549744997, 5015.774290157025, 5037.571806396498, 5072.289879416959, 4893.608511319015, 4898.387701537308, 4940.802367905244, 4960.379952505937, 5001.699898006132, 4967.304577359245, 5007.899842003212, 5028.446870844131, 5041.722705251246, 5056.191009438472, 4632.119897219518, 4666.78999445019, 4773.355596994361, 4805.639577031667, 4859.927101093415, 4883.096627123993, 4932.704037757746, 4945.554900059012, 4957.950420495749, 5008.799648014038, 4787.114383838862, 4806.255030470283, 4878.975605121952, 4881.072596206709, 4892.902141957212, 4644.7213167210075, 4738.905221895612, 4758.97681998372, 4808.182608956556, 4918.114739346952, 4745.098431298043, 4821.397325334333, 4842.685225460334, 4866.367372241586, 4917.754112294442], "mootools.html": [1093.8140516112271, 1486.086057074899, 1553.7358649029663, 1568.4902406717815, 1576.9053856768587, 5737.913931291034, 6110.816675499736, 6241.687915604224, 6319.77880774173, 6367.172267605205, 6221.657808820513, 6274.341194174603, 6330.240371155468, 6335.461485773715, 6345.428911397973, 1898.2027548429623, 1920.3374835681668, 1922.9134688939032, 1928.874623149498, 1930.362980216525, 1841.1622711666228, 1848.0759620189906, 1854.8330650241476, 1865.4496923407628, 1873.906304684767, 1850.2598960415874, 1871.9906400467978, 1873.5035215667858, 1874.1753628403526, 1877.643247782917, 1815.8093400192988, 1821.9180136893872, 1830.880992735468, 1843.7695288089055, 1853.379117995473, 1835.1374853818684, 1848.574827789616, 1865.0395046551037, 1871.4759867237196, 1881.5672395349147, 5628.240187574666, 6246.3441338659695, 6259.968700156515, 6282.465990390822, 6285.497160227171, 3572.1962558424407, 3808.409696497047, 3906.8632597859223, 3954.426608141803, 3957.525096988351, 2419.70963484383, 2518.1312447205682, 2548.643189953408, 2555.565553855849, 2559.9104031358997, 770.2990278846223, 794.7695168401157, 795.4074214710021, 805.399977017126, 827.1728271728272, 8026.959865200637, 8177.4684645497855, 8202.015758109064, 8206.83586328276, 8225.588720563948, 3389.322135572895, 3445.8277086145595, 3492.2666240089357, 3502.3345564342694, 3533.7526373154146, 6829.419499342513, 6830.658467076626, 6864.039034535169, 6872.381485666314, 6884.0362349271145, 3940.014996250937, 3943.0536671198706, 3944.9408258876138, 3951.2295102454746, 3970.82131304092, 3654.1230104774663, 3663.230721548505, 3682.742208045411, 3689.7048236141045, 3717.4423836424753, 2744.464829358296, 2761.351082495612, 2788.9721102788712, 2791.441711657636, 2795.9301017474727, 811.4968719394013, 817.5421763812284, 825.0841565861889, 838.3837879158814, 838.8825564420986, 900.4732231644431, 943.8772959515219, 1145.2613064573304, 1159.5419809175328, 1159.6694941941507, 6014.51883849291, 6094.695265236721, 6112.816615501542, 6125.203723515914, 6139.508839292936, 900.8243392538392, 910.3991365698607, 928.224932181636, 1000.799840031982, 1018.6129270877168, 4889.755512224375, 4905.730184839868, 4943.406791185081, 4950.405951285797, 4959.553640172329, 7083.610401427868, 7179.389751871149, 7300.744473943492, 7459.515131516434, 7486.775396738107, 7359.264073592705, 7400.740974065882, 7434.442416818761, 7446.73936412223, 7461.962690186514, 5887.587868849225, 5888.087346461305, 5978.790742324085, 6029.939700602938, 6030.849228769228, 5967.8209653710455, 5972.850678733066, 5976.940230597638, 5983.401659834156, 5996.5502587305255, 6627.867442651216, 6692.263850976291, 6833.3166683331265, 6834.760783372558, 6848.452123829982, 6763.797086087426, 6871.209810871614, 6912.101426814482, 6932.376086152271, 6987.510874238755, 5164.664296820694, 5267.631265811357, 5290.947090529045, 5308.548773354308, 5315.920261196163, 5711.942880571141, 6107.480864126422, 6134.171886795226, 6140.815775526741, 6164.47601953839, 5492.258545096361, 5620.971895140498, 5691.914621280767, 5757.971210143923, 5797.9420205797405, 5307.230451584576, 5506.311711036121, 5664.348599910898, 5696.971515142398, 5709.543236540983, 5709.115087161496, 5770.394108618535, 5796.130580412803, 5806.796762113475, 5839.824805255849, 5246.31797866275, 5301.814436494704, 5309.654872433434, 5327.840164795062, 5334.039872822929, 5034.672746271481, 5144.562712169508, 5155.716435596079, 5155.948440515547, 5354.54486368663], "ext.html": [465.98136074557016, 467.1731036066163, 478.66015129258227, 485.9416869975601, 503.20996036223096, 27190.592141117875, 27679.16962491126, 31690.366192676134, 32043.67956320436, 32150.0, 35195.0, 36018.2796344073, 36057.63942360575, 36159.276814463694, 36199.475065616796, 6965.616891070989, 7844.92155078449, 7897.921020789805, 8042.276195142436, 8042.959785201066, 4797.9760101199445, 4804.975975120119, 4875.171220892439, 5256.290400795881, 7118.893216601755, 9107.089291070906, 9174.0, 9195.632174713004, 9312.068793120701, 9461.57422915967, 5314.707691076989, 7193.0, 7456.217097204824, 9106.408083474553, 9263.120003599648, 9143.497107659075, 9148.634054637872, 9304.30217733666, 9340.859887101698, 9380.5309734513, 32943.0, 33518.32963340744, 33565.49651755226, 33602.6639733602, 33772.0, 2540.61890716394, 2591.598302263152, 2617.0971014999795, 2618.9214323570322, 2679.3971356444645, 23400.0, 23865.284041478782, 23991.0, 24195.0, 24553.14064007769, 2087.1651339464183, 2105.4525823285903, 2129.446343950584, 2145.313499680103, 2241.4284357488737, 234905.0, 235010.0, 235103.0, 237292.0, 238397.0, 43176.0, 51037.0, 51747.223791643155, 51811.74094129505, 51818.0, 40892.0, 41181.38227926583, 53419.73290133524, 54449.72775136099, 54601.726991365584, 14080.71838563223, 14117.223552704494, 14131.78802317966, 14208.715825683428, 14249.0, 10885.510152043176, 10922.344659320466, 10962.451877406098, 11029.0, 11035.44822758859, 16486.258118384703, 16687.582810429838, 16711.331546737994, 16743.748843767353, 16811.579710507336, 7268.418526517866, 7437.219091995263, 7463.664135113933, 7464.768313228256, 7469.327760501472, 781.2929298984428, 781.9765407037798, 873.7990262239721, 881.6385282034463, 888.2583043159035, 24288.1499147529, 24366.75633243645, 24427.511449770904, 24924.252272431855, 25136.24591262265, 927.3137877970254, 930.4835816121982, 933.9533023348805, 997.5012493753123, 1001.5743309093606, 12280.570180043835, 12361.567345142877, 12413.379331033413, 12460.501579936883, 12839.550615728405, 267735.0, 271496.0, 275330.0, 275346.0, 276522.0, 47583.76208118937, 47808.760956194994, 48170.27744583834, 48226.0, 48386.0, 1194.199886076331, 1198.7592841408925, 1213.5873802907054, 1216.4586758892385, 1218.0925210717894, 20745.89627051855, 24105.276841694777, 24647.50704985926, 24649.0, 24666.260012199662, 38024.429633554966, 38429.0, 38453.80773096117, 38543.80728096342, 38676.226475470896, 226124.0, 227330.0, 227452.0, 227729.0, 228422.0, 22602.434939126655, 23016.194433194756, 23051.654225186972, 25537.361565961, 25772.484550309266, 33817.83091084529, 33875.4918676225, 34685.0, 34847.65152348444, 35314.47028294629, 26710.86644566765, 27156.333894923933, 27919.162425127277, 28062.2984425391, 28315.575266370608, 28170.577441338806, 28464.573031404132, 28589.428211436072, 29113.7088629111, 29321.85339073291, 29312.120636380943, 29337.0, 29882.103536893927, 29883.70116298809, 30361.848190758905, 25216.74783252144, 26443.867780660974, 26622.7337726628, 26727.465450691267, 26926.0, 20268.290609829175, 20533.0257224608, 20566.588668226254, 20602.484937876074, 20697.17099364471], "prototype.html": [269.66561463784905, 279.7691904179052, 280.9213420242333, 282.27314664738293, 288.6406424002118, 5229.660072095311, 5238.13570760824, 5241.659292146008, 5247.134222853229, 5272.393674727403, 4990.65065445419, 5050.520200580948, 5115.079285728568, 5118.283440318349, 5140.357455318085, 3963.365861462167, 3978.2043591281713, 3992.1416895367634, 3996.820143093568, 4020.4974378202724, 3983.661388781957, 4005.3791662292247, 4007.0783719744477, 4011.8796436106963, 4017.517897852247, 3825.713071519633, 3888.9805550972205, 3897.941530877039, 3987.760734355948, 3992.361222204448, 3947.032976920644, 3974.0263635409365, 3994.2810294147043, 4005.7997100144876, 4017.5982401759884, 3405.3189362127428, 3408.829558522064, 3424.6917777399904, 3424.8972530824117, 3427.622961474236, 4939.061578300148, 5036.269740887551, 5066.062778385974, 5081.085404627165, 5120.769565369567, 4172.624463798273, 4293.957060429387, 4453.53237910018, 4456.977715111436, 4460.910781784379, 5342.225377320306, 5426.375966763833, 5437.728113594344, 5443.401225865152, 5475.0, 3660.432632941898, 3686.1706116123923, 3688.2807852468777, 3694.538182727159, 3710.517632707758, 5632.7746890124345, 5735.799247026334, 5738.483536481736, 5749.540036797046, 5756.7985120521, 3621.7826930384263, 3711.814409279525, 3729.198222382201, 3733.253349330145, 3746.756460830037, 3787.3182827090836, 3828.062124779391, 3833.501644786216, 3840.8271627776817, 3860.034991252187, 4463.464384273843, 4487.483939346952, 4488.192125417456, 4488.9102217956115, 4500.099980004013, 5518.117101263779, 5539.446055394428, 5540.9168862467095, 5557.444255574491, 5559.27729395176, 1369.664432214114, 1377.4696741754497, 1382.8271466066742, 1391.1792042694858, 1397.3711829676686, 875.8292133034124, 882.1972005475116, 897.6768363389175, 899.4153800030033, 901.8782464367226, 5319.255304257407, 5332.866678333073, 5365.651232669864, 5376.247325374451, 5387.676739395571, 5737.598368114275, 5745.770169193269, 5750.654960702372, 5764.193012978187, 5786.0, 5326.946730532645, 5339.332583427072, 5346.545543628835, 5351.25082488452, 5364.0, 3076.8153910765427, 3150.2439414540345, 3175.7459403247685, 3195.936081278408, 3196.7282780963415, 5772.595918285764, 5799.710014499258, 5828.446297601721, 5828.504577110908, 5840.795572154954, 5869.0, 5888.705564721747, 5900.350961394243, 5921.703914804242, 5929.14027466015, 5436.592255580768, 5609.887802243932, 5826.41735826414, 5835.037218858841, 5838.620489668158, 5686.687232202103, 5713.857153571194, 5738.22533957927, 5742.16738572913, 5771.94228057714, 5623.268975033219, 5640.379558248672, 5641.069223578063, 5665.688387138747, 5682.943170568242, 5766.048601980626, 5772.826815195551, 5784.363719990882, 5828.70856457167, 5839.124131380157, 3697.815109244473, 3778.414345776409, 3783.5270591176104, 3824.655780979725, 3827.004978705501, 5801.622894511843, 5817.0, 5833.883322333614, 5835.533157347487, 5858.297004359504, 5612.859678507906, 5623.0, 5624.128260119688, 5636.436356364331, 5648.604597678123, 5465.72671366438, 5588.552915766648, 5591.804286849941, 5622.2128901954575, 5653.152027195953, 5497.725113744376, 5502.284702988586, 5502.532284755841, 5510.476504732044, 5518.0, 5679.261695979496, 5687.317521897398, 5692.373838877803, 5701.743421545957, 5705.7147142643535, 5501.504864562208, 5502.724863756876, 5521.585881059017, 5522.282103326542, 5528.75120619565], "yui.html": [603.8339456649423, 642.7429028388647, 657.2474516678403, 680.7991642465473, 690.2855544511432, 12092.818607720881, 12325.5069797208, 12343.691407714812, 12345.444454999524, 12374.257544547323, 11452.0, 11498.19512634116, 11552.075833933286, 11599.768004639924, 11782.057435405168, 615.0681717198448, 617.1452538234532, 621.0776996160698, 744.330102907385, 765.6248438265266, 763.9847203055936, 770.9553554933069, 778.8792737125726, 779.629675903944, 784.3764207455058, 809.2150613904503, 810.1250649298743, 812.9309008734265, 814.1288820961573, 814.5601375257384, 645.3739872323862, 659.8746238214771, 796.7211475983418, 804.5977011494252, 819.8852160697508, 597.7160848596925, 598.1984141250745, 601.6089541797822, 607.7417097733489, 608.4341562347059, 11818.290902545874, 11983.340916249603, 12008.939955300255, 12037.518499260019, 12122.0, 10097.091261786401, 10128.0, 10558.155347572252, 10822.404767737771, 10857.131429485622, 7920.207979202091, 8229.947671141348, 8279.213474719892, 8508.149185081442, 8660.566971651393, 2834.5889845972424, 2889.8266104033823, 2903.11455006223, 2942.5880376747273, 2952.0110762894456, 42622.57377426217, 42857.0, 43061.0, 43072.0, 43806.56193438057, 7909.881351779728, 7913.32736717374, 7969.362451003905, 7996.440249182501, 8049.718259860877, 17089.0, 17102.40141595063, 17250.137493125294, 17264.050477223875, 17365.0, 5982.940170598238, 6200.751969921243, 6225.470834978987, 6311.96844015777, 6366.649834259068, 3348.6316505184896, 3428.434308339146, 3438.9312213755584, 3454.3436747017986, 3462.0, 2458.6557881896547, 2565.9486810264066, 2566.230130960704, 2570.434504409027, 2571.524268010424, 364.41329459570073, 367.4304827517391, 372.2684924124109, 373.06733167082297, 380.3135340710045, 482.65249020705033, 501.7315736081252, 506.3063602864026, 515.3841159814061, 532.8055259830212, 6324.367563243639, 6960.373566378949, 7386.630668466555, 7440.813979650552, 7701.997480654958, 457.6316065567184, 462.64145287401857, 516.0350145228447, 523.351839691164, 547.3158551810237, 3210.646828848825, 3220.404225218342, 3239.4492936200904, 3272.885449009273, 3339.4322965095994, 48858.0, 48872.26691599629, 49403.50596494061, 49543.50456495389, 49761.0, 41961.79019104885, 43132.0, 43247.35128973068, 43341.78329108397, 43350.0, 39741.20517589632, 41178.38232426516, 41413.37879931804, 41450.585494144674, 42253.57746422497, 6671.432928201158, 6728.192616886005, 7119.75080872167, 7146.857062858609, 7169.978894216608, 28747.137585872457, 28873.711262887104, 29049.12852614425, 29502.0, 29553.55669664914, 37385.4392184112, 37535.0, 41787.79106104572, 41993.79003104965, 42015.57984420239, 6552.148220731275, 6579.0, 6584.967075164594, 6698.430633396216, 6789.898151527632, 9553.426794392359, 9614.134727874525, 9629.807403852024, 9644.083812037845, 9689.0, 8940.195382415613, 8965.686200982935, 8987.41581797181, 9211.815763684555, 9254.814903702023, 9060.909390906007, 9256.0, 9275.027278026411, 9287.257019438293, 9437.103475169848, 8935.731928041909, 9091.409058411182, 9236.907630923604, 9307.395019323721, 9330.160285574331, 7574.962125189339, 7645.0, 7787.0, 8080.555569443502, 8192.44343574719, 7591.240875912586, 7633.732819351296, 7691.769246922601, 7711.460197786101, 7993.560354180576]}, "summary": {"suite": 5779.74498970775, "subtests": {"jquery.html": {"filtered": 6628.395180613665, "value": 6628.395180613665}, "dojo.html": {"filtered": 4596.386887155206, "value": 4596.386887155206}, "mootools.html": {"filtered": 3649.31419602498, "value": 3649.31419602498}, "ext.html": {"filtered": 15438.305685267014, "value": 15438.305685267014}, "prototype.html": {"filtered": 4139.0477069692015, "value": 4139.0477069692015}, "yui.html": {"filtered": 5246.5253906624575, "value": 5246.5253906624575}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0052"}, "testrun": {"date": 1446839281, "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": "20151105001636", "branch": "Fx-Team", "revision": "ff8ebe5251ec227be26994089871cb40c1da3011"}}, {"talos_counters": {}, "results": {"audio-dft": [181.0, 187.0, 188.0, 188.0, 183.0, 183.0, 187.0, 187.0, 184.0, 183.0], "ai-astar": [123.0, 125.0, 120.0, 128.0, 127.0, 122.0, 123.0, 121.0, 117.0, 126.0], "imaging-gaussian-blur": [127.0, 132.0, 142.0, 142.0, 135.0, 142.0, 139.0, 136.0, 142.0, 141.0], "audio-beat-detection": [179.0, 151.0, 180.0, 190.0, 147.0, 173.0, 175.0, 147.0, 188.0, 149.0], "json-stringify-tinderbox": [74.0, 73.0, 74.0, 76.0, 78.0, 78.0, 78.0, 77.0, 78.0, 78.0], "stanford-crypto-pbkdf2": [167.0, 175.0, 177.0, 173.0, 175.0, 176.0, 176.0, 176.0, 173.0, 166.0], "json-parse-financial": [63.0, 65.0, 66.0, 67.0, 66.0, 66.0, 67.0, 77.0, 65.0, 65.0], "stanford-crypto-sha256-iterative": [77.0, 79.0, 83.0, 81.0, 82.0, 81.0, 80.0, 81.0, 84.0, 82.0], "audio-fft": [86.0, 86.0, 100.0, 99.0, 99.0, 80.0, 82.0, 95.0, 94.0, 80.0], "imaging-darkroom": [148.0, 147.0, 148.0, 147.0, 140.0, 147.0, 147.0, 147.0, 146.0, 141.0], "stanford-crypto-ccm": [143.0, 156.0, 154.0, 148.0, 149.0, 142.0, 147.0, 142.0, 155.0, 154.0], "audio-oscillator": [108.0, 108.0, 160.0, 105.0, 104.0, 104.0, 152.0, 105.0, 104.0, 157.0], "stanford-crypto-aes": [94.0, 99.0, 100.0, 101.0, 102.0, 101.0, 101.0, 101.0, 104.0, 102.0], "imaging-desaturate": [119.0, 118.0, 119.0, 120.0, 118.0, 124.0, 123.0, 119.0, 118.0, 118.0]}, "summary": {"suite": 1737.2000000000003, "subtests": {"audio-fft": {"filtered": 90.1, "value": 90.1}, "stanford-crypto-pbkdf2": {"filtered": 173.4, "value": 173.4}, "audio-beat-detection": {"filtered": 167.9, "value": 167.9}, "stanford-crypto-ccm": {"filtered": 149.0, "value": 149.0}, "imaging-darkroom": {"filtered": 145.8, "value": 145.8}, "json-parse-financial": {"filtered": 66.7, "value": 66.7}, "audio-oscillator": {"filtered": 120.7, "value": 120.7}, "ai-astar": {"filtered": 123.2, "value": 123.2}, "audio-dft": {"filtered": 185.1, "value": 185.1}, "stanford-crypto-sha256-iterative": {"filtered": 81.0, "value": 81.0}, "json-stringify-tinderbox": {"filtered": 76.4, "value": 76.4}, "imaging-gaussian-blur": {"filtered": 137.8, "value": 137.8}, "stanford-crypto-aes": {"filtered": 100.5, "value": 100.5}, "imaging-desaturate": {"filtered": 119.6, "value": 119.6}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0052"}, "testrun": {"date": 1446839281, "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": "20151105001636", "branch": "Fx-Team", "revision": "ff8ebe5251ec227be26994089871cb40c1da3011"}}, {"talos_counters": {}, "results": {"DeltaBlue": [222.17285047767163], "Encrypt": [361.53289949385396], "NavierStokes": [6622.516556291391], "Decrypt": [6924.137931034483], "Splay": [707.7140835102618], "Richards": [190.4036557501904], "RegExp": [33866.666666666664], "Earley": [1033.0578512396694], "Boyer": [14400.0], "RayTrace": [2364.066193853428]}, "summary": {"suite": 15947.388861359681, "subtests": {"DeltaBlue": {"filtered": 297.59711800000014, "value": 297.59711800000014}, "Encrypt": {"filtered": 736.256646, "value": 736.256646}, "NavierStokes": {"filtered": 224.08400000000015, "value": 224.08400000000015}, "Decrypt": {"filtered": 38.4424750996016, "value": 38.4424750996016}, "Splay": {"filtered": 115.14678300000004, "value": 115.14678300000004}, "RegExp": {"filtered": 26.899163385826792, "value": 26.899163385826792}, "Richards": {"filtered": 185.406104, "value": 185.406104}, "Earley": {"filtered": 645.1361840000003, "value": 645.1361840000003}, "Boyer": {"filtered": 46.282152777777746, "value": 46.282152777777746}, "RayTrace": {"filtered": 313.0153469999999, "value": 313.0153469999999}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0052"}, "testrun": {"date": 1446839281, "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": "20151105001636", "branch": "Fx-Team", "revision": "ff8ebe5251ec227be26994089871cb40c1da3011"}}] 12:08:17 INFO - RETURN: dromaeo_css: 5779.75 12:08:17 INFO - RETURN: kraken: 1737.20 12:08:17 INFO - RETURN: v8_7: 15947.39 12:08:17 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,55]]", "result": "15947.39"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,55]]", "result": "1737.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,55]]", "result": "5779.75"}}} 12:08:17 INFO - Return code: 0 12:08:17 INFO - # TBPL SUCCESS # 12:08:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:08:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:08:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:08:17 INFO - 2015-11-06 12:08:17.964 screenresolution[2279:21628] starting screenresolution argv=screenresolution get 12:08:17 INFO - 2015-11-06 12:08:17.967 screenresolution[2279:21628] Display 0: 1600x1200x32@60 12:08:17 INFO - 2015-11-06 12:08:17.974 screenresolution[2280:21631] starting screenresolution argv=screenresolution list 12:08:17 INFO - Available Modes on Display 0 12:08:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:08:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:08:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:08:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:08:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:08:18 INFO - Intel HD Graphics 3000: 12:08:18 INFO - Chipset Model: Intel HD Graphics 3000 12:08:18 INFO - Type: GPU 12:08:18 INFO - Bus: Built-In 12:08:18 INFO - VRAM (Total): 512 MB 12:08:18 INFO - VRAM (Dynamic, Max): 10 12:08:18 INFO - Vendor: Intel (0x8086) 12:08:18 INFO - Device ID: 0x0116 12:08:18 INFO - Revision ID: 0x0009 12:08:18 INFO - Displays: 12:08:18 INFO - Display: 12:08:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:08:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:08:18 INFO - Display Serial Number: 1600x1200 60 12:08:18 INFO - Main Display: Yes 12:08:18 INFO - Mirror: Off 12:08:18 INFO - Online: Yes 12:08:18 INFO - Rotation: Supported 12:08:18 INFO - Return code: 0 12:08:18 INFO - Running post-action listener: _resource_record_post_action 12:08:18 INFO - Running post-run listener: _resource_record_post_run 12:08:19 INFO - Total resource usage - Wall time: 1258s; CPU: 30.0%; Read bytes: 114688; Write bytes: 682426368; Read time: 80; Write time: 54323 12:08:19 INFO - install - Wall time: 41s; CPU: 30.0%; Read bytes: 340734464; Write bytes: 335067136; Read time: 36275; Write time: 5555 12:08:19 INFO - run-tests - Wall time: 1217s; CPU: 30.0%; Read bytes: 106496; Write bytes: 336898048; Read time: 39; Write time: 47784 12:08:19 INFO - Running post-run listener: _upload_blobber_files 12:08:19 INFO - Blob upload gear active. 12:08:19 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 12:08:19 INFO - Copying logs to upload dir... 12:08:19 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1320.660994 ========= master_lag: 5.62 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 6 secs) (at 2015-11-06 12:08:24.973299) ========= ========= Started set props: build_url (results: 0, elapsed: 6 secs) (at 2015-11-06 12:08:24.977900) ========= 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.tEu47zSKc1/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.4ldzly0Q3v/Listeners TMPDIR=/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/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/2LkZYG3HTmaPgd6O0Zsr7g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010028 build_url: 'https://queue.taskcluster.net/v1/task/2LkZYG3HTmaPgd6O0Zsr7g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 6.77 ========= ========= Finished set props: build_url (results: 0, elapsed: 6 secs) (at 2015-11-06 12:08:31.754484) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 5 secs) (at 2015-11-06 12:08:31.754927) ========= 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.tEu47zSKc1/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.4ldzly0Q3v/Listeners TMPDIR=/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/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.005275 ========= master_lag: 5.63 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 5 secs) (at 2015-11-06 12:08:37.394615) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-06 12:08:37.395039) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-06 12:08:37.467291) ========= ========= Total master_lag: 21.63 =========