builder: fx-team_yosemite_test-dromaeojs slave: t-yosemite-r5-0001 starttime: 1446505505.74 results: success (0) buildid: 20151102141306 builduid: bdc06352fe954b5783843958a91cc0cc revision: 901a0736dd16ba366d2de0ec08cab975429fa4b2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-02 15:05:05.740826) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-02 15:05:05.741238) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-02 15:05:05.741518) ========= 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.emPCSi6okE/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.VK2HLjgPY7/Listeners TMPDIR=/var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/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.005808 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-02 15:05:05.798014) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 6 secs) (at 2015-11-02 15:05:05.798293) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 6 secs) (at 2015-11-02 15:05:12.285396) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 15:05:12.288678) ========= 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.emPCSi6okE/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.VK2HLjgPY7/Listeners TMPDIR=/var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/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.051836 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 15:05:12.379141) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-02 15:05:12.379422) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-02 15:05:12.379767) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 15:05:12.380039) ========= 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.emPCSi6okE/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.VK2HLjgPY7/Listeners TMPDIR=/var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/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-02 15:05:12-- 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.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% 965M=0s 2015-11-02 15:05:12 (965 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.221610 ========= master_lag: 0.10 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 15:05:12.704857) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 15:05:12.705130) ========= 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.emPCSi6okE/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.VK2HLjgPY7/Listeners TMPDIR=/var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/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.137270 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 15:05:12.859903) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 15:05:12.860214) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 901a0736dd16ba366d2de0ec08cab975429fa4b2 --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 901a0736dd16ba366d2de0ec08cab975429fa4b2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.emPCSi6okE/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.VK2HLjgPY7/Listeners TMPDIR=/var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/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-02 15:05:12,950 truncating revision to first 12 chars 2015-11-02 15:05:12,950 Setting DEBUG logging. 2015-11-02 15:05:12,951 attempt 1/10 2015-11-02 15:05:12,951 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/901a0736dd16?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-02 15:05:13,211 unpacking tar archive at: fx-team-901a0736dd16/testing/mozharness/ program finished with exit code 0 elapsedTime=0.517156 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 15:05:13.409509) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-02 15:05:13.409845) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-02 15:05:13.430619) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-02 15:05:13.430924) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-02 15:05:13.431289) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 48 secs) (at 2015-11-02 15:05:13.431570) ========= /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.emPCSi6okE/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.VK2HLjgPY7/Listeners TMPDIR=/var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/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 15:05:13 INFO - MultiFileLogger online at 20151102 15:05:13 in /builds/slave/test 15:05:13 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 15:05:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:05:13 INFO - {'append_to_log': False, 15:05:13 INFO - 'base_work_dir': '/builds/slave/test', 15:05:13 INFO - 'blob_upload_branch': 'Fx-Team', 15:05:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:05:13 INFO - 'branch': 'Fx-Team', 15:05:13 INFO - 'buildbot_json_path': 'buildprops.json', 15:05:13 INFO - 'config_files': ('talos/mac_config.py',), 15:05:13 INFO - 'default_actions': ('clobber', 15:05:13 INFO - 'read-buildbot-config', 15:05:13 INFO - 'download-and-extract', 15:05:13 INFO - 'populate-webroot', 15:05:13 INFO - 'create-virtualenv', 15:05:13 INFO - 'install', 15:05:13 INFO - 'run-tests'), 15:05:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:05:13 INFO - 'download_minidump_stackwalk': True, 15:05:13 INFO - 'download_symbols': 'ondemand', 15:05:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:05:13 INFO - 'tooltool.py': '/tools/tooltool.py', 15:05:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:05:13 INFO - '/tools/misc-python/virtualenv.py')}, 15:05:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:05:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:05:13 INFO - 'installer_path': 'installer.exe', 15:05:13 INFO - 'log_level': 'info', 15:05:13 INFO - 'log_name': 'talos', 15:05:13 INFO - 'log_to_console': True, 15:05:13 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:05:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:05:13 INFO - 'opt_config_files': (), 15:05:13 INFO - 'pip_index': False, 15:05:13 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:05:13 INFO - 'cmd': ('bash', 15:05:13 INFO - '-c', 15:05:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:05:13 INFO - 'enabled': True, 15:05:13 INFO - 'halt_on_failure': False, 15:05:13 INFO - 'name': 'check_screen_resolution'},), 15:05:13 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:05:13 INFO - 'cmd': ('bash', 15:05:13 INFO - '-c', 15:05:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:05:13 INFO - 'enabled': True, 15:05:13 INFO - 'halt_on_failure': False, 15:05:13 INFO - 'name': 'check_screen_resolution'},), 15:05:13 INFO - 'run_cmd_checks_enabled': True, 15:05:13 INFO - 'sps_profile': False, 15:05:13 INFO - 'sps_profile_interval': 0, 15:05:13 INFO - 'suite': 'dromaeojs', 15:05:13 INFO - 'system_bits': '64', 15:05:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:05:13 INFO - 'title': 't-yosemite-r5-0001', 15:05:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:05:13 INFO - 'use_talos_json': True, 15:05:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:05:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:05:13 INFO - 'work_dir': 'build'} 15:05:13 INFO - ##### 15:05:13 INFO - ##### Running clobber step. 15:05:13 INFO - ##### 15:05:13 INFO - Running pre-action listener: _resource_record_pre_action 15:05:13 INFO - Running main action method: clobber 15:05:13 INFO - rmtree: /builds/slave/test/build 15:05:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:05:17 INFO - Running post-action listener: _resource_record_post_action 15:05:17 INFO - ##### 15:05:17 INFO - ##### Running read-buildbot-config step. 15:05:17 INFO - ##### 15:05:17 INFO - Running pre-action listener: _resource_record_pre_action 15:05:17 INFO - Running main action method: read_buildbot_config 15:05:17 INFO - Using buildbot properties: 15:05:17 INFO - { 15:05:17 INFO - "properties": { 15:05:17 INFO - "buildnumber": 1186, 15:05:17 INFO - "product": "firefox", 15:05:17 INFO - "script_repo_revision": "production", 15:05:17 INFO - "builddir": "fx-team_yosemite_test-dromaeojs", 15:05:17 INFO - "repository": "", 15:05:17 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 fx-team talos dromaeojs", 15:05:17 INFO - "buildid": "20151102141306", 15:05:17 INFO - "slavename": "t-yosemite-r5-0001", 15:05:17 INFO - "pgo_build": "False", 15:05:17 INFO - "basedir": "/builds/slave/test", 15:05:17 INFO - "project": "", 15:05:17 INFO - "platform": "yosemite", 15:05:17 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 15:05:17 INFO - "slavebuilddir": "test", 15:05:17 INFO - "scheduler": "tests-fx-team-macosx64-talos", 15:05:17 INFO - "branch": "fx-team", 15:05:17 INFO - "repo_path": "integration/fx-team", 15:05:17 INFO - "stage_platform": "macosx64", 15:05:17 INFO - "builduid": "bdc06352fe954b5783843958a91cc0cc", 15:05:17 INFO - "revision": "901a0736dd16ba366d2de0ec08cab975429fa4b2" 15:05:17 INFO - }, 15:05:17 INFO - "sourcestamp": { 15:05:17 INFO - "repository": "", 15:05:17 INFO - "hasPatch": false, 15:05:17 INFO - "project": "", 15:05:17 INFO - "branch": "fx-team-macosx64-talos", 15:05:17 INFO - "changes": [ 15:05:17 INFO - { 15:05:17 INFO - "category": null, 15:05:17 INFO - "files": [ 15:05:17 INFO - { 15:05:17 INFO - "url": null, 15:05:17 INFO - "name": "https://queue.taskcluster.net/v1/task/zYPh7WkfQa2iw_mWkdvzsw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 15:05:17 INFO - } 15:05:17 INFO - ], 15:05:17 INFO - "repository": "", 15:05:17 INFO - "rev": "901a0736dd16ba366d2de0ec08cab975429fa4b2", 15:05:17 INFO - "who": "dmosedale@mozilla.com", 15:05:17 INFO - "when": 1446505058, 15:05:17 INFO - "number": 6611599, 15:05:17 INFO - "comments": "Bug 1213906-Change email invitation to fit new user journey, r=dmose", 15:05:17 INFO - "project": "", 15:05:17 INFO - "at": "Mon 02 Nov 2015 14:57:38", 15:05:17 INFO - "branch": "fx-team-macosx64-talos", 15:05:17 INFO - "revlink": "", 15:05:17 INFO - "properties": [ 15:05:17 INFO - [ 15:05:17 INFO - "buildid", 15:05:17 INFO - "20151102141306", 15:05:17 INFO - "Change" 15:05:17 INFO - ], 15:05:17 INFO - [ 15:05:17 INFO - "builduid", 15:05:17 INFO - "bdc06352fe954b5783843958a91cc0cc", 15:05:17 INFO - "Change" 15:05:17 INFO - ], 15:05:17 INFO - [ 15:05:17 INFO - "pgo_build", 15:05:17 INFO - "False", 15:05:17 INFO - "Change" 15:05:17 INFO - ] 15:05:17 INFO - ], 15:05:17 INFO - "revision": "901a0736dd16ba366d2de0ec08cab975429fa4b2" 15:05:17 INFO - } 15:05:17 INFO - ], 15:05:17 INFO - "revision": "901a0736dd16ba366d2de0ec08cab975429fa4b2" 15:05:17 INFO - } 15:05:17 INFO - } 15:05:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/zYPh7WkfQa2iw_mWkdvzsw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 15:05:17 INFO - Running post-action listener: _resource_record_post_action 15:05:17 INFO - ##### 15:05:17 INFO - ##### Running download-and-extract step. 15:05:17 INFO - ##### 15:05:17 INFO - Running pre-action listener: _resource_record_pre_action 15:05:17 INFO - Running main action method: download_and_extract 15:05:17 INFO - mkdir: /builds/slave/test/build/tests 15:05:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:17 INFO - https://queue.taskcluster.net/v1/task/zYPh7WkfQa2iw_mWkdvzsw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:05:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zYPh7WkfQa2iw_mWkdvzsw/artifacts/public/build/test_packages.json 15:05:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zYPh7WkfQa2iw_mWkdvzsw/artifacts/public/build/test_packages.json 15:05:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zYPh7WkfQa2iw_mWkdvzsw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 15:05:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zYPh7WkfQa2iw_mWkdvzsw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 15:05:23 INFO - Downloaded 1149 bytes. 15:05:23 INFO - Reading from file /builds/slave/test/build/test_packages.json 15:05:23 INFO - Using the following test package requirements: 15:05:23 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 15:05:23 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:05:23 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 15:05:23 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:05:23 INFO - u'jsshell-mac.zip'], 15:05:23 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:05:23 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 15:05:23 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 15:05:23 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:05:23 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 15:05:23 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:05:23 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 15:05:23 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:05:23 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 15:05:23 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 15:05:23 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:05:23 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 15:05:23 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:05:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:23 INFO - https://queue.taskcluster.net/v1/task/zYPh7WkfQa2iw_mWkdvzsw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:05:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zYPh7WkfQa2iw_mWkdvzsw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:05:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zYPh7WkfQa2iw_mWkdvzsw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:05:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zYPh7WkfQa2iw_mWkdvzsw/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 15:05:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zYPh7WkfQa2iw_mWkdvzsw/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 15:05:25 INFO - Downloaded 17452601 bytes. 15:05:25 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 15:05:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:05:25 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 15:05:29 INFO - Return code: 0 15:05:29 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 15:05:29 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')]} 15:05:29 INFO - https://queue.taskcluster.net/v1/task/zYPh7WkfQa2iw_mWkdvzsw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:05:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zYPh7WkfQa2iw_mWkdvzsw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:05:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zYPh7WkfQa2iw_mWkdvzsw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:05:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zYPh7WkfQa2iw_mWkdvzsw/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 15:05:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zYPh7WkfQa2iw_mWkdvzsw/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 15:05:32 INFO - Downloaded 17452601 bytes. 15:05:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 15:05:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:05:32 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 15:05:36 INFO - Return code: 0 15:05: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')]} 15:05:36 INFO - https://queue.taskcluster.net/v1/task/zYPh7WkfQa2iw_mWkdvzsw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 15:05:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zYPh7WkfQa2iw_mWkdvzsw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 15:05:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zYPh7WkfQa2iw_mWkdvzsw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 15:05:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zYPh7WkfQa2iw_mWkdvzsw/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 15:05:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zYPh7WkfQa2iw_mWkdvzsw/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 15:05:37 INFO - Downloaded 11131307 bytes. 15:05:37 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 15:05:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 15:05:37 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 15:05:38 INFO - Return code: 0 15:05:38 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')]} 15:05:38 INFO - https://queue.taskcluster.net/v1/task/zYPh7WkfQa2iw_mWkdvzsw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 15:05:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zYPh7WkfQa2iw_mWkdvzsw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 15:05:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zYPh7WkfQa2iw_mWkdvzsw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 15:05:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zYPh7WkfQa2iw_mWkdvzsw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 15:05:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zYPh7WkfQa2iw_mWkdvzsw/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 15:05:41 INFO - Downloaded 108707093 bytes. 15:05:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/zYPh7WkfQa2iw_mWkdvzsw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 15:05:41 INFO - mkdir: /builds/slave/test/properties 15:05:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:05:41 INFO - Writing to file /builds/slave/test/properties/build_url 15:05:41 INFO - Contents: 15:05:41 INFO - build_url:https://queue.taskcluster.net/v1/task/zYPh7WkfQa2iw_mWkdvzsw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 15:05:41 INFO - Running post-action listener: _resource_record_post_action 15:05:41 INFO - Running post-action listener: set_extra_try_arguments 15:05:41 INFO - ##### 15:05:41 INFO - ##### Running populate-webroot step. 15:05:41 INFO - ##### 15:05:41 INFO - Running pre-action listener: _resource_record_pre_action 15:05:41 INFO - Running main action method: populate_webroot 15:05:41 INFO - Guessing talos json url... 15:05:41 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')]} 15:05:41 INFO - https://queue.taskcluster.net/v1/task/zYPh7WkfQa2iw_mWkdvzsw/artifacts/public/build/firefox-45.0a1.en-US.mac.txt matches https://queue.taskcluster.net 15:05:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zYPh7WkfQa2iw_mWkdvzsw/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 15:05:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zYPh7WkfQa2iw_mWkdvzsw/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 15:05:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zYPh7WkfQa2iw_mWkdvzsw/artifacts/public/build/firefox-45.0a1.en-US.mac.txt to /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 15:05:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zYPh7WkfQa2iw_mWkdvzsw/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 15:05:42 INFO - Downloaded 103 bytes. 15:05:42 INFO - Reading from file /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 15:05:42 INFO - Contents: 15:05:42 INFO - 20151102141306 15:05:42 INFO - https://hg.mozilla.org/integration/fx-team/rev/901a0736dd16ba366d2de0ec08cab975429fa4b2 15:05:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:42 INFO - trying https://hg.mozilla.org/integration/fx-team/raw-file/901a0736dd/testing/talos/talos.json 15:05:42 INFO - Downloading https://hg.mozilla.org/integration/fx-team/raw-file/901a0736dd/testing/talos/talos.json to /builds/slave/test/build/talos.json 15:05:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/integration/fx-team/raw-file/901a0736dd/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 15:05:42 INFO - Downloaded 4264 bytes. 15:05:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:05:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:05:42 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 15:05:42 INFO - '../fennec_ids.txt'], 15:05:42 INFO - 'tests': ['tcheck2']}, 15:05:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:05:42 INFO - '--tppagecycles', 15:05:42 INFO - '7'], 15:05:42 INFO - 'tests': ['tsvgm']}}, 15:05:42 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:05:42 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:05:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:05:42 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:05:42 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:05:42 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:05:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:05:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:42 INFO - 'talos_options': ['--e10s'], 15:05:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:05:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:42 INFO - 'tests': ['damp', 'tps']}, 15:05:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:42 INFO - 'talos_options': ['--e10s'], 15:05:42 INFO - 'tests': ['damp', 'tps']}, 15:05:42 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:05:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:05:42 INFO - 'other': {'tests': ['a11yr', 15:05:42 INFO - 'ts_paint', 15:05:42 INFO - 'tpaint', 15:05:42 INFO - 'sessionrestore', 15:05:42 INFO - 'sessionrestore_no_auto_restore']}, 15:05:42 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:05:42 INFO - 'tests': ['a11yr', 15:05:42 INFO - 'ts_paint', 15:05:42 INFO - 'tpaint', 15:05:42 INFO - 'sessionrestore', 15:05:42 INFO - 'sessionrestore_no_auto_restore']}, 15:05:42 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:05:42 INFO - 'tests': ['a11yr', 15:05:42 INFO - 'ts_paint', 15:05:42 INFO - 'tpaint', 15:05:42 INFO - 'sessionrestore', 15:05:42 INFO - 'sessionrestore_no_auto_restore']}, 15:05:42 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:05:42 INFO - 'tests': ['a11yr', 15:05:42 INFO - 'ts_paint', 15:05:42 INFO - 'tpaint', 15:05:42 INFO - 'sessionrestore', 15:05:42 INFO - 'sessionrestore_no_auto_restore']}, 15:05:42 INFO - 'other_l64': {'tests': ['a11yr', 15:05:42 INFO - 'ts_paint', 15:05:42 INFO - 'tpaint', 15:05:42 INFO - 'sessionrestore', 15:05:42 INFO - 'sessionrestore_no_auto_restore']}, 15:05:42 INFO - 'other_nol64': {'tests': ['a11yr', 15:05:42 INFO - 'ts_paint', 15:05:42 INFO - 'tpaint', 15:05:42 INFO - 'sessionrestore', 15:05:42 INFO - 'sessionrestore_no_auto_restore']}, 15:05:42 INFO - 'svgr': {'tests': ['tsvgx', 15:05:42 INFO - 'tsvgr_opacity', 15:05:42 INFO - 'tart', 15:05:42 INFO - 'tscrollx', 15:05:42 INFO - 'cart']}, 15:05:42 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:05:42 INFO - 'tests': ['tsvgx', 15:05:42 INFO - 'tsvgr_opacity', 15:05:42 INFO - 'tart', 15:05:42 INFO - 'tscrollx', 15:05:42 INFO - 'cart']}, 15:05:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:42 INFO - 'tests': ['tp5o']}, 15:05:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:42 INFO - 'talos_options': ['--e10s'], 15:05:42 INFO - 'tests': ['tp5o']}, 15:05:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:42 INFO - 'talos_options': ['--xperf_path', 15:05:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:05:42 INFO - 'tests': ['tp5n']}, 15:05:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:42 INFO - 'talos_options': ['--e10s', 15:05:42 INFO - '--xperf_path', 15:05:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 15:05:42 INFO - 'C:/slave/talos-data/talos/xperf.config'], 15:05:42 INFO - 'tests': ['tp5n']}}, 15:05:42 INFO - 'talos.zip': {'path': '', 15:05:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:05:42 INFO - Running post-action listener: _resource_record_post_action 15:05:42 INFO - ##### 15:05:42 INFO - ##### Running create-virtualenv step. 15:05:42 INFO - ##### 15:05:42 INFO - Running pre-action listener: _resource_record_pre_action 15:05:42 INFO - Running main action method: create_virtualenv 15:05:42 INFO - Creating virtualenv /builds/slave/test/build/venv 15:05:42 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 15:05:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:05:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:05:43 INFO - Using real prefix '/tools/python27' 15:05:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:05:44 INFO - Installing distribute.............................................................................................................................................................................................done. 15:05:47 INFO - Installing pip.................done. 15:05:47 INFO - Return code: 0 15:05:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:05:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1095d4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109641228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febd2f02b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095899f0>, '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 0x1092e8cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109553990>, '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.emPCSi6okE/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.VK2HLjgPY7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/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 15:05:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:05:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:05:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.emPCSi6okE/Render', 15:05:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:05:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:05:47 INFO - 'HOME': '/Users/cltbld', 15:05:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:05:47 INFO - 'LOGNAME': 'cltbld', 15:05:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:47 INFO - 'MOZ_NO_REMOTE': '1', 15:05:47 INFO - 'NO_EM_RESTART': '1', 15:05:47 INFO - 'PAGER': '/bin/cat', 15:05:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:05:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:47 INFO - 'PWD': '/builds/slave/test', 15:05:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:05:47 INFO - 'SHELL': '/bin/bash', 15:05:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VK2HLjgPY7/Listeners', 15:05:47 INFO - 'TMPDIR': '/var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/T/', 15:05:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:05:47 INFO - 'USER': 'cltbld', 15:05:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:05:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:05:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:47 INFO - 'XPC_FLAGS': '0x0', 15:05:47 INFO - 'XPC_SERVICE_NAME': '0', 15:05:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:05:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:48 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:05:48 INFO - Cleaning up... 15:05:48 INFO - Return code: 0 15:05:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:05: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')]} 15:05:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05: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')]} 15:05:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1095d4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109641228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febd2f02b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095899f0>, '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 0x1092e8cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109553990>, '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.emPCSi6okE/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.VK2HLjgPY7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/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 15:05:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 15:05:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 15:05:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.emPCSi6okE/Render', 15:05:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:05:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:05:48 INFO - 'HOME': '/Users/cltbld', 15:05:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:05:48 INFO - 'LOGNAME': 'cltbld', 15:05:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:48 INFO - 'MOZ_NO_REMOTE': '1', 15:05:48 INFO - 'NO_EM_RESTART': '1', 15:05:48 INFO - 'PAGER': '/bin/cat', 15:05:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:05:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:48 INFO - 'PWD': '/builds/slave/test', 15:05:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:05:48 INFO - 'SHELL': '/bin/bash', 15:05:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VK2HLjgPY7/Listeners', 15:05:48 INFO - 'TMPDIR': '/var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/T/', 15:05:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:05:48 INFO - 'USER': 'cltbld', 15:05:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:05:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:05:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:48 INFO - 'XPC_FLAGS': '0x0', 15:05:48 INFO - 'XPC_SERVICE_NAME': '0', 15:05:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:05:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:48 INFO - Downloading/unpacking psutil>=0.7.1 15:05:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:50 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 15:05:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:05:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:05:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:05:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:05:51 INFO - Installing collected packages: psutil 15:05:51 INFO - Running setup.py install for psutil 15:05:51 INFO - building 'psutil._psutil_osx' extension 15:05:51 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 15:05:52 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 15:05:52 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 15:05:52 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 15:05:53 INFO - building 'psutil._psutil_posix' extension 15:05:53 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 15:05:53 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:05:53 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:05:53 INFO - ^ 15:05:53 INFO - 1 warning generated. 15:05:53 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 15:05:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:05:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:05:53 INFO - Successfully installed psutil 15:05:53 INFO - Cleaning up... 15:05:53 INFO - Return code: 0 15:05:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:05:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:53 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 0x1095d4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109641228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febd2f02b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095899f0>, '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 0x1092e8cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109553990>, '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.emPCSi6okE/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.VK2HLjgPY7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/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 15:05:53 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 15:05:53 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 15:05:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.emPCSi6okE/Render', 15:05:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:05:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:05:53 INFO - 'HOME': '/Users/cltbld', 15:05:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:05:53 INFO - 'LOGNAME': 'cltbld', 15:05:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:53 INFO - 'MOZ_NO_REMOTE': '1', 15:05:53 INFO - 'NO_EM_RESTART': '1', 15:05:53 INFO - 'PAGER': '/bin/cat', 15:05:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:05:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:53 INFO - 'PWD': '/builds/slave/test', 15:05:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:05:53 INFO - 'SHELL': '/bin/bash', 15:05:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VK2HLjgPY7/Listeners', 15:05:53 INFO - 'TMPDIR': '/var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/T/', 15:05:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:05:53 INFO - 'USER': 'cltbld', 15:05:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:05:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:05:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:53 INFO - 'XPC_FLAGS': '0x0', 15:05:53 INFO - 'XPC_SERVICE_NAME': '0', 15:05:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:05:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:05:53 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 15:05:53 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 15:05:53 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 15:05:53 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 15:05:53 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 15:05:53 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 15:05:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:05:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:05:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:05:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:05:56 INFO - Installing collected packages: mozsystemmonitor 15:05:56 INFO - Running setup.py install for mozsystemmonitor 15:05:56 INFO - Successfully installed mozsystemmonitor 15:05:56 INFO - Cleaning up... 15:05:56 INFO - Return code: 0 15:05:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:05:56 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')]} 15:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:56 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')]} 15:05:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:56 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 0x1095d4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109641228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febd2f02b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095899f0>, '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 0x1092e8cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109553990>, '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.emPCSi6okE/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.VK2HLjgPY7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/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 15:05:56 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 15:05:56 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 15:05:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.emPCSi6okE/Render', 15:05:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:05:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:05:56 INFO - 'HOME': '/Users/cltbld', 15:05:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:05:56 INFO - 'LOGNAME': 'cltbld', 15:05:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:56 INFO - 'MOZ_NO_REMOTE': '1', 15:05:56 INFO - 'NO_EM_RESTART': '1', 15:05:56 INFO - 'PAGER': '/bin/cat', 15:05:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:05:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:56 INFO - 'PWD': '/builds/slave/test', 15:05:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:05:56 INFO - 'SHELL': '/bin/bash', 15:05:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VK2HLjgPY7/Listeners', 15:05:56 INFO - 'TMPDIR': '/var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/T/', 15:05:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:05:56 INFO - 'USER': 'cltbld', 15:05:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:05:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:05:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:56 INFO - 'XPC_FLAGS': '0x0', 15:05:56 INFO - 'XPC_SERVICE_NAME': '0', 15:05:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:05:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:56 INFO - Downloading/unpacking blobuploader==1.2.4 15:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:59 INFO - Downloading blobuploader-1.2.4.tar.gz 15:05:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 15:05:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:05:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:05: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 15:05: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 15:05: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 15:05: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 15:05: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 15:05: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 15:05:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 15:05:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:05:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:05: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 15:05: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 15:05: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 15:05: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 15:05: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 15:05: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 15:06:00 INFO - Downloading docopt-0.6.1.tar.gz 15:06:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 15:06:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:06:00 INFO - Installing collected packages: blobuploader, requests, docopt 15:06:00 INFO - Running setup.py install for blobuploader 15:06:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:06:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:06:00 INFO - Running setup.py install for requests 15:06:01 INFO - Running setup.py install for docopt 15:06:01 INFO - Successfully installed blobuploader requests docopt 15:06:01 INFO - Cleaning up... 15:06:01 INFO - Return code: 0 15:06:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:06: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')]} 15:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:06:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06: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')]} 15:06:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:06:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1095d4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109641228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febd2f02b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095899f0>, '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 0x1092e8cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109553990>, '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.emPCSi6okE/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.VK2HLjgPY7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/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 15:06:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:06:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:06:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.emPCSi6okE/Render', 15:06:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:06:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:06:01 INFO - 'HOME': '/Users/cltbld', 15:06:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:06:01 INFO - 'LOGNAME': 'cltbld', 15:06:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:01 INFO - 'MOZ_NO_REMOTE': '1', 15:06:01 INFO - 'NO_EM_RESTART': '1', 15:06:01 INFO - 'PAGER': '/bin/cat', 15:06:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:06:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:01 INFO - 'PWD': '/builds/slave/test', 15:06:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:06:01 INFO - 'SHELL': '/bin/bash', 15:06:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VK2HLjgPY7/Listeners', 15:06:01 INFO - 'TMPDIR': '/var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/T/', 15:06:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:06:01 INFO - 'USER': 'cltbld', 15:06:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:06:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:06:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:01 INFO - 'XPC_FLAGS': '0x0', 15:06:01 INFO - 'XPC_SERVICE_NAME': '0', 15:06:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:06:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:06:01 INFO - Running setup.py (path:/var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/T/pip-iCdGGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:06:01 INFO - Running setup.py (path:/var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/T/pip-P_LK7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:06:01 INFO - Running setup.py (path:/var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/T/pip-YH3nVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:06:01 INFO - Running setup.py (path:/var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/T/pip-KG0pJ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:06:02 INFO - Running setup.py (path:/var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/T/pip-fPMfPO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:06:02 INFO - Running setup.py (path:/var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/T/pip-1p2b82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:06:02 INFO - Running setup.py (path:/var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/T/pip-etSFJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:06:02 INFO - Running setup.py (path:/var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/T/pip-N5Zh3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:06:02 INFO - Running setup.py (path:/var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/T/pip-6G0tMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:06:02 INFO - Running setup.py (path:/var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/T/pip-QabBRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:06:02 INFO - Running setup.py (path:/var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/T/pip-0IdSZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:06:02 INFO - Running setup.py (path:/var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/T/pip-XS2oBt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:06:03 INFO - Running setup.py (path:/var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/T/pip-ouAfrr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:06:03 INFO - Running setup.py (path:/var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/T/pip-4XUghm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:06:03 INFO - Running setup.py (path:/var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/T/pip-lnl5rL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:06:03 INFO - Running setup.py (path:/var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/T/pip-P0GO7K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:06:03 INFO - Running setup.py (path:/var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/T/pip-Ny9Jn7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:06:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:06:03 INFO - Running setup.py install for manifestparser 15:06:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:06:03 INFO - Running setup.py install for mozcrash 15:06:04 INFO - Running setup.py install for mozdebug 15:06:04 INFO - Running setup.py install for mozdevice 15:06:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:06:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:06:04 INFO - Running setup.py install for mozfile 15:06:04 INFO - Running setup.py install for mozhttpd 15:06:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:06:04 INFO - Running setup.py install for mozinfo 15:06:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:06:04 INFO - Running setup.py install for mozInstall 15:06:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:06:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:06:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:06:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:06:05 INFO - Running setup.py install for mozleak 15:06:05 INFO - Running setup.py install for mozlog 15:06:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:06:05 INFO - Running setup.py install for moznetwork 15:06:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:06:05 INFO - Running setup.py install for mozprocess 15:06:05 INFO - Running setup.py install for mozprofile 15:06:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:06:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:06:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:06:05 INFO - Running setup.py install for mozrunner 15:06:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:06:06 INFO - Running setup.py install for mozscreenshot 15:06:06 INFO - Running setup.py install for moztest 15:06:06 INFO - Running setup.py install for mozversion 15:06:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:06:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:06:06 INFO - Cleaning up... 15:06:06 INFO - Return code: 0 15:06:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:06:06 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')]} 15:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:06:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:06 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')]} 15:06:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:06:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:06 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 0x1095d4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109641228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febd2f02b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095899f0>, '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 0x1092e8cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109553990>, '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.emPCSi6okE/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.VK2HLjgPY7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/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 15:06:06 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 15:06:06 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 15:06:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.emPCSi6okE/Render', 15:06:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:06:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:06:06 INFO - 'HOME': '/Users/cltbld', 15:06:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:06:06 INFO - 'LOGNAME': 'cltbld', 15:06:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:06 INFO - 'MOZ_NO_REMOTE': '1', 15:06:06 INFO - 'NO_EM_RESTART': '1', 15:06:06 INFO - 'PAGER': '/bin/cat', 15:06:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:06:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:06 INFO - 'PWD': '/builds/slave/test', 15:06:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:06:06 INFO - 'SHELL': '/bin/bash', 15:06:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VK2HLjgPY7/Listeners', 15:06:06 INFO - 'TMPDIR': '/var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/T/', 15:06:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:06:06 INFO - 'USER': 'cltbld', 15:06:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:06:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:06:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:06 INFO - 'XPC_FLAGS': '0x0', 15:06:06 INFO - 'XPC_SERVICE_NAME': '0', 15:06:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:06:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:06:06 INFO - Running setup.py (path:/var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/T/pip-1JWUSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:06:07 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)) 15:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:06:07 INFO - Running setup.py (path:/var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/T/pip-KLV1PZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:06:07 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)) 15:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:06:07 INFO - Running setup.py (path:/var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/T/pip-hELJzn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:06:07 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)) 15:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:06:07 INFO - Running setup.py (path:/var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/T/pip-kSxCLk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:06:07 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)) 15:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:06:07 INFO - Running setup.py (path:/var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/T/pip-24efqM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:06:07 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)) 15:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:06:07 INFO - Running setup.py (path:/var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/T/pip-RYOx94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:06:07 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)) 15:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:06:07 INFO - Running setup.py (path:/var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/T/pip-aMHeuN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:06:07 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)) 15:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:06:07 INFO - Running setup.py (path:/var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/T/pip-VDyrWM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:06:07 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)) 15:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:06:07 INFO - Running setup.py (path:/var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/T/pip-Rry3Og-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:06:08 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)) 15:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:06:08 INFO - Running setup.py (path:/var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/T/pip-gmA60O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:06:08 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)) 15:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:06:08 INFO - Running setup.py (path:/var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/T/pip-14rvAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:06:08 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)) 15:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:06:08 INFO - Running setup.py (path:/var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/T/pip-zOcdfw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:06:08 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)) 15:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:06:08 INFO - Running setup.py (path:/var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/T/pip-dsQ5b8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:06:08 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)) 15:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:06:08 INFO - Running setup.py (path:/var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/T/pip-uhFYp0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:06:08 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)) 15:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:06:08 INFO - Running setup.py (path:/var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/T/pip-44foVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:06:08 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)) 15:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:06:08 INFO - Running setup.py (path:/var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/T/pip-KbMH6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:06:09 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)) 15:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:06:09 INFO - Running setup.py (path:/var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/T/pip-v5YNth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:06:09 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)) 15:06:09 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)) 15:06:09 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)) 15:06:09 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)) 15:06:09 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)) 15:06:09 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)) 15:06:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:06:09 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 15:06:09 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 15:06:09 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 15:06:09 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 15:06:09 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 15:06:09 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 15:06:11 INFO - Downloading blessings-1.5.1.tar.gz 15:06:11 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 15:06:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:06:11 INFO - Installing collected packages: blessings 15:06:11 INFO - Running setup.py install for blessings 15:06:11 INFO - Successfully installed blessings 15:06:11 INFO - Cleaning up... 15:06:12 INFO - Return code: 0 15:06:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:06:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:06:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:06:12 INFO - Reading from file tmpfile_stdout 15:06:12 INFO - Current package versions: 15:06:12 INFO - blessings == 1.5.1 15:06:12 INFO - blobuploader == 1.2.4 15:06:12 INFO - docopt == 0.6.1 15:06:12 INFO - manifestparser == 1.1 15:06:12 INFO - mozInstall == 1.12 15:06:12 INFO - mozcrash == 0.16 15:06:12 INFO - mozdebug == 0.1 15:06:12 INFO - mozdevice == 0.47 15:06:12 INFO - mozfile == 1.2 15:06:12 INFO - mozhttpd == 0.7 15:06:12 INFO - mozinfo == 0.9 15:06:12 INFO - mozleak == 0.1 15:06:12 INFO - mozlog == 3.0 15:06:12 INFO - moznetwork == 0.27 15:06:12 INFO - mozprocess == 0.22 15:06:12 INFO - mozprofile == 0.27 15:06:12 INFO - mozrunner == 6.11 15:06:12 INFO - mozscreenshot == 0.1 15:06:12 INFO - mozsystemmonitor == 0.0 15:06:12 INFO - moztest == 0.7 15:06:12 INFO - mozversion == 1.4 15:06:12 INFO - psutil == 3.1.1 15:06:12 INFO - requests == 1.2.3 15:06:12 INFO - wsgiref == 0.1.2 15:06:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:06:12 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')]} 15:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:06:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:12 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')]} 15:06:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:06:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:12 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 0x1095d4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109641228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febd2f02b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095899f0>, '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 0x1092e8cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109553990>, '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.emPCSi6okE/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.VK2HLjgPY7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/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 15:06:12 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 15:06:12 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 15:06:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.emPCSi6okE/Render', 15:06:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:06:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:06:12 INFO - 'HOME': '/Users/cltbld', 15:06:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:06:12 INFO - 'LOGNAME': 'cltbld', 15:06:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:12 INFO - 'MOZ_NO_REMOTE': '1', 15:06:12 INFO - 'NO_EM_RESTART': '1', 15:06:12 INFO - 'PAGER': '/bin/cat', 15:06:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:06:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:12 INFO - 'PWD': '/builds/slave/test', 15:06:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:06:12 INFO - 'SHELL': '/bin/bash', 15:06:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VK2HLjgPY7/Listeners', 15:06:12 INFO - 'TMPDIR': '/var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/T/', 15:06:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:06:12 INFO - 'USER': 'cltbld', 15:06:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:06:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:06:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:12 INFO - 'XPC_FLAGS': '0x0', 15:06:12 INFO - 'XPC_SERVICE_NAME': '0', 15:06:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:06:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:06:12 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)) 15:06:12 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)) 15:06:12 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)) 15:06:12 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)) 15:06:12 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)) 15:06:12 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)) 15:06:12 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)) 15:06:12 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)) 15:06:12 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)) 15:06:12 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)) 15:06:12 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)) 15:06:12 INFO - Cleaning up... 15:06:12 INFO - Return code: 0 15:06:12 INFO - Running post-action listener: _resource_record_post_action 15:06:12 INFO - Running post-action listener: _start_resource_monitoring 15:06:12 INFO - Starting resource monitoring. 15:06:12 INFO - ##### 15:06:12 INFO - ##### Running install step. 15:06:12 INFO - ##### 15:06:12 INFO - Running pre-action listener: _resource_record_pre_action 15:06:12 INFO - Running main action method: install 15:06:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:06:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:06:12 INFO - Reading from file tmpfile_stdout 15:06:12 INFO - Detecting whether we're running mozinstall >=1.0... 15:06:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:06:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:06:13 INFO - Reading from file tmpfile_stdout 15:06:13 INFO - Output received: 15:06:13 INFO - Usage: mozinstall [options] installer 15:06:13 INFO - Options: 15:06:13 INFO - -h, --help show this help message and exit 15:06:13 INFO - -d DEST, --destination=DEST 15:06:13 INFO - Directory to install application into. [default: 15:06:13 INFO - "/builds/slave/test"] 15:06:13 INFO - --app=APP Application being installed. [default: firefox] 15:06:13 INFO - mkdir: /builds/slave/test/build/application 15:06:13 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'] 15:06:13 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 15:06:51 INFO - Reading from file tmpfile_stdout 15:06:51 INFO - Output received: 15:06:51 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:06:51 INFO - Running post-action listener: _resource_record_post_action 15:06:51 INFO - ##### 15:06:51 INFO - ##### Running run-tests step. 15:06:51 INFO - ##### 15:06:51 INFO - Running pre-action listener: _resource_record_pre_action 15:06:51 INFO - Running main action method: run_tests 15:06:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:06:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:06:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:06:51 INFO - 2015-11-02 15:06:51.154 screenresolution[1627:7647] starting screenresolution argv=screenresolution get 15:06:51 INFO - 2015-11-02 15:06:51.158 screenresolution[1627:7647] Display 0: 1600x1200x32@60 15:06:51 INFO - 2015-11-02 15:06:51.165 screenresolution[1628:7649] starting screenresolution argv=screenresolution list 15:06:51 INFO - Available Modes on Display 0 15:06:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:06:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:06:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:06:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:06:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:06:51 INFO - Intel HD Graphics 3000: 15:06:51 INFO - Chipset Model: Intel HD Graphics 3000 15:06:51 INFO - Type: GPU 15:06:51 INFO - Bus: Built-In 15:06:51 INFO - VRAM (Total): 512 MB 15:06:51 INFO - VRAM (Dynamic, Max): 10 15:06:51 INFO - Vendor: Intel (0x8086) 15:06:51 INFO - Device ID: 0x0116 15:06:51 INFO - Revision ID: 0x0009 15:06:51 INFO - Displays: 15:06:51 INFO - Display: 15:06:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:06:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:06:51 INFO - Display Serial Number: 1600x1200 60 15:06:51 INFO - Main Display: Yes 15:06:51 INFO - Mirror: Off 15:06:51 INFO - Online: Yes 15:06:51 INFO - Rotation: Supported 15:06:51 INFO - Return code: 0 15:06:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:06:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:06:51 INFO - Python 2.7.3 15:06:51 INFO - Return code: 0 15:06:51 INFO - grabbing minidump binary from tooltool 15:06:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:06:51 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 0x1095899f0>, '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 0x1092e8cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109553990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:06:51 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 15:06:51 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 15:06:51 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:06:51 INFO - Return code: 0 15:06:51 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:06:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:06:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:06:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:06:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:06:51 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/zYPh7WkfQa2iw_mWkdvzsw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0001', '--webServer', 'localhost'] in /builds/slave/test/build 15:06:51 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/zYPh7WkfQa2iw_mWkdvzsw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0001 --webServer localhost 15:06:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.emPCSi6okE/Render', 15:06:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:06:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:06:51 INFO - 'HOME': '/Users/cltbld', 15:06:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:06:51 INFO - 'LOGNAME': 'cltbld', 15:06:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:06:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:06:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:51 INFO - 'MOZ_NO_REMOTE': '1', 15:06:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:06:51 INFO - 'NO_EM_RESTART': '1', 15:06:51 INFO - 'PAGER': '/bin/cat', 15:06:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:06:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:51 INFO - 'PWD': '/builds/slave/test', 15:06:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:06:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:06:51 INFO - 'SHELL': '/bin/bash', 15:06:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VK2HLjgPY7/Listeners', 15:06:51 INFO - 'TMPDIR': '/var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/T/', 15:06:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:06:51 INFO - 'USER': 'cltbld', 15:06:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:06:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:06:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:51 INFO - 'XPC_FLAGS': '0x0', 15:06:51 INFO - 'XPC_SERVICE_NAME': '0', 15:06:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:06:51 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/zYPh7WkfQa2iw_mWkdvzsw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0001', '--webServer', 'localhost'] with output_timeout 3600 15:06:51 INFO - mozversion INFO | application_buildid: 20151102141306 15:06:51 INFO - mozversion INFO | application_changeset: 901a0736dd16ba366d2de0ec08cab975429fa4b2 15:06:51 INFO - mozversion INFO | application_display_name: Nightly 15:06:51 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:06:51 INFO - mozversion INFO | application_name: Firefox 15:06:51 INFO - mozversion INFO | application_remotingname: firefox 15:06:51 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 15:06:51 INFO - mozversion INFO | application_vendor: Mozilla 15:06:51 INFO - mozversion INFO | application_version: 45.0a1 15:06:51 INFO - mozversion INFO | platform_buildid: 20151102141306 15:06:51 INFO - mozversion INFO | platform_changeset: 901a0736dd16ba366d2de0ec08cab975429fa4b2 15:06:51 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 15:06:51 INFO - mozversion INFO | platform_version: 45.0a1 15:06:51 INFO - 2015-11-02 15:06:51,903 DEBUG : using testdate: 1446505611 15:06:51 INFO - 2015-11-02 15:06:51,903 DEBUG : actual date: 1446505611 15:06:51 INFO - 2015-11-02 15:06:51,912 INFO : starting webserver on 'localhost:49265' 15:06:51 INFO - 2015-11-02 15:06:51,914 INFO : Starting test suite t-yosemite-r5-0001 15:06:51 INFO - 2015-11-02 15:06:51,914 INFO : Starting test dromaeo_css 15:06:51 INFO - 2015-11-02 15:06:51,914 DEBUG : operating with platform_type : mac_ 15:06:51 INFO - 2015-11-02 15:06:51,915 INFO : Initialising browser for dromaeo_css test... 15:06:51 INFO - 2015-11-02 15:06:51,940 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/T/tmp37nGXp/profile http://localhost:49265/getInfo.html 15:06:54 INFO - 2015-11-02 15:06:54,658 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:06:54 INFO - 2015-11-02 15:06:54,658 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:06:54 INFO - 2015-11-02 15:06:54,658 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 15:06:54 INFO - 2015-11-02 15:06:54,658 DEBUG : BROWSER_OUTPUT: __metrics 15:06:54 INFO - 2015-11-02 15:06:54,676 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:06:55 INFO - 2015-11-02 15:06:55,406 INFO : Browser initialized. 15:06:55 INFO - 2015-11-02 15:06:55,406 INFO : Running cycle 1/1 for dromaeo_css test... 15:06:55 INFO - 2015-11-02 15:06:55,407 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/T/tmp37nGXp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:07:07 INFO - 2015-11-02 15:07:07,347 DEBUG : BROWSER_OUTPUT: RSS: Main: 221458432 15:07:07 INFO - 2015-11-02 15:07:07,347 DEBUG : BROWSER_OUTPUT: 15:07:59 INFO - 2015-11-02 15:07:59,157 DEBUG : BROWSER_OUTPUT: 1446505679152 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] 15:10:09 INFO - 2015-11-02 15:10:09,687 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49265/tests/dromaeo/cssquery-ext.html) 15:10:10 INFO - 2015-11-02 15:10:10,925 DEBUG : BROWSER_OUTPUT: RSS: Main: 338604032 15:10:10 INFO - 2015-11-02 15:10:10,926 DEBUG : BROWSER_OUTPUT: 15:13:13 INFO - 2015-11-02 15:13:13,530 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-ext.html (next: http://localhost:49265/tests/dromaeo/cssquery-jquery.html) 15:13:14 INFO - 2015-11-02 15:13:14,111 DEBUG : BROWSER_OUTPUT: RSS: Main: 356732928 15:13:14 INFO - 2015-11-02 15:13:14,111 DEBUG : BROWSER_OUTPUT: 15:16:16 INFO - 2015-11-02 15:16:16,095 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49265/tests/dromaeo/cssquery-mootools.html) 15:16:16 INFO - 2015-11-02 15:16:16,684 DEBUG : BROWSER_OUTPUT: RSS: Main: 331829248 15:16:16 INFO - 2015-11-02 15:16:16,684 DEBUG : BROWSER_OUTPUT: 15:19:18 INFO - 2015-11-02 15:19:18,676 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49265/tests/dromaeo/cssquery-prototype.html) 15:19:19 INFO - 2015-11-02 15:19:19,274 DEBUG : BROWSER_OUTPUT: RSS: Main: 315432960 15:19:19 INFO - 2015-11-02 15:19:19,274 DEBUG : BROWSER_OUTPUT: 15:22:22 INFO - 2015-11-02 15:22:22,359 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49265/tests/dromaeo/cssquery-yui.html) 15:22:22 INFO - 2015-11-02 15:22:22,963 DEBUG : BROWSER_OUTPUT: RSS: Main: 314978304 15:22:22 INFO - 2015-11-02 15:22:22,963 DEBUG : BROWSER_OUTPUT: 15:25:25 INFO - 2015-11-02 15:25:25,407 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-yui.html (next: http://localhost:49265/tests/dromaeo/cssquery-dojo.html) 15:25:25 INFO - 2015-11-02 15:25:25,672 DEBUG : BROWSER_OUTPUT: RSS: Main: 392544256 15:25:25 INFO - 2015-11-02 15:25:25,672 DEBUG : BROWSER_OUTPUT: 15:25:25 INFO - 2015-11-02 15:25:25,672 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:25:25 INFO - 2015-11-02 15:25:25,672 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:25:25 INFO - 2015-11-02 15:25:25,672 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:25:25 INFO - 2015-11-02 15:25:25,672 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:25:25 INFO - 2015-11-02 15:25:25,677 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3194.6965038321355;3256.9674303256975;3282.0974232086164;3294.5552350432686;3320.020593924792;5263.473652634734;5403.2705584746045;5450.264214331064;5476.315460567429;5482.862928426786;5412.864678383043;5418.2685337479425;5438.483344082306;5481.177823326503;5592.804251851186;4996.225585034307;5030.06943715412;5049.4698056704065;5101.00530396571;5101.642884998052;5047;5075.238714192882;5109.412417571971;5121.487851214886;5122.6926384416865;4820.060088282787;4846.491118432549;4992.051510213048;5063.645544811865;5085.160948443502;5021.623378246646;5063.367079115111;5073.670211436245;5091.389033316026;5116.539511443951;5022.221555658843;5036.043151801146;5049.368828896388;5053.570446512051;5055;5216.217567364888;5323.1749078892835;5328.760205790749;5336.813211537617;5482;5815.069588865804;5818.7672493100645;5819.621724587888;5826.533877289807;5834.708264586796;5914.674692891889;5924.407559244084;5927.9703601481715;5933.139694744238;5951.166836642873;5339.733013349317;5392.299001129828;5447.046766815792;5455.208994695826;5489.094299440628;5924.348321684612;5975.43233392827;5981.3719559445635;5998.910016349758;6005.549583781234;5697.487226149667;5701.885962280731;5716.399778023248;5721.742521586539;5735.311762588516;5652.547796176296;5653.971730141405;5782;5791.971040144772;5798.594098413155;5700.657960522382;5701.71491425427;5721.227634269404;5733.598648094677;5854.121881717691;5727.570432217601;5739.196512488255;5740.54075673945;5745.482906538348;5746.9712651436475;4410.470743510799;4497.707649002804;4564.132814765184;4566.178087944202;4569.588737013618;4116.794160291974;4149.294619914622;4151.294279972412;4173.269677806372;4189.2668782962855;5344.893102138013;5376.327959005124;5384.811531596375;5392.514673679309;5424.83725488236;5717.628354156966;5734.827955161351;5807.361190269067;5814.360420353758;5819.359870414251;5453.045716999509;5460.781568737206;5464.808731694372;5464.972675136679;5489.945100549024;5178.300929374486;5185.714785686823;5195.844124676266;5211.895762084737;5246.396664383568;5677.290338707661;5775.740091695968;5780.479756821822;5860.120981852756;5943.55423343251;5823.534117270693;5843.065109582446;5845.386234445322;5870.295564532284;5886.6173698709445;5862.7654893805475;5869.647821130746;5886.499647529837;5888.823335299948;5893.852653683521;5683.1759394886685;5777.133429985536;5781.4218578141845;5794.623349482439;5810.564207684525;5817.709114544171;5852.209951656472;5940.524758019435;5953.315368732651;5992.910106348321;5786.334571524329;5818.912716309174;5826.359100498857;5841.065429531254;5852.297724273115;5468.808591699271;5612.635178713371;5807.680577568274;5825.70871456417;5831.35855055952;5400.62195646301;5454.727263636723;5469.535089517276;5505.642133261325;5571.637843540157;5613.101903695389;5731.484166424875;5742.425757424391;5757.971210143923;5784.652920824764;5353.277307563585;5433.972830135982;5673.517750991212;5679.176519404746;5679.77280908759 15:25:25 INFO - 2015-11-02 15:25:25,677 DEBUG : BROWSER_OUTPUT: |1;ext.html;560.2184951991969;562.1455387810528;573.3062993777529;581.9563532735043;586.3960121075291;31476.055718328458;32055.358892822158;38928.22143557127;40027;40034;42679.786601067026;43127.78436107823;43203.78398108013;43211.35182972258;43245.56754432455;8252.133525979776;9261.907380926188;9490.952545237264;9497.335186536946;9512.66705665302;8402.453840500348;11261.324320540753;11393.259438136494;11487.081033517341;11497;11234.606788762396;11322.886771132265;11359.034482069033;11361.715957101056;11367.09063274936;8460.8730869037;8654.567271636455;11087.168462365315;11223.270487418291;11279.210455268134;10955.671329860117;11108.333499990027;11120.55517779296;11150.721231969266;11163;39781.40327895055;40259.7987010066;40270;40298.79850600757;40331.7983410084;3160.7629427792776;3241.951370729441;3252.3332716793;3404.3872103021445;3467.6705712957228;27599.862000689867;28240.85879570589;28364;28381;28479.57280640792;2343.8593684378993;2369.5142495788323;2369.964450533226;2392.8564286142714;2469.333280014386;292217;293664;294743;295294;296337;49848.50151498439;51438.74280628573;59909;60413.395866041654;63932;60419.39580604138;60533.69733151394;60757.69621151866;60908;60909;16755.413560525565;16931.576710582332;16933.153342332833;16934.49196524106;16958.321667133423;12864.356782160854;12933.965282777355;12947.223166610034;12955.740885182244;12959.546415875588;19140;19171;19189;19206.711899321523;19310.420687379403;7971;8226.753197404087;8234.505929644241;8250.793730156794;8279.213474719892;965.1072757699101;1030.4744580264119;1039.0025575447503;1061.8141825180562;1168.281506873284;28876.625778523994;28922.566161507595;29247.268818279714;29404.11787646374;29435.558466623017;1005.626365802773;1045.8640376750973;1136.6817291158488;1171.3410558033218;1277.5017743080207;15182.240887955559;15233.923830380778;15426.768598471032;15448.150351730537;15737.763933541006;340679;348081;348427;350152;350296;56293.71853140708;56498.15252771212;56505;56572.71713641405;56602.71698641563;1398.4056775870417;1400.9439622414989;1410.4710733474947;1412.3573773933042;1414.8090007849014;28877.71122288834;28952.710472895844;29038.274043148245;29439.411211775216;29650.851745741133;43243.35134972915;44055;46984.53015469802;47374.999999998625;47430.52569474261;327234;330554;333276;334181.30365437095;334627;29606.851965740032;29934;29955.101346959626;30001.549976750804;30025.5496167562;38042;41310.79344603378;41401.37897931594;41425.37861932134;41648.58351416447;33880.83059584686;35120.47319290264;35406.46890296699;35502;37616.81191594025;34899.47650785291;35154.64845351616;35814.28371432609;35817.283654327286;35879.10302242465;34893.47659785156;35381.29237415186;35495.290094198484;35722.64277357193;36195.45706814347;29630.407391852474;31352.21619459532;31548.36903261876;31588.36823263568;31605.20986975344;24197.395065122808;24312.27063188107;24331;24632.261032169063;24708.505829883663 15:25:25 INFO - 2015-11-02 15:25:25,678 DEBUG : BROWSER_OUTPUT: |2;jquery.html;341.17776159455707;342.83543898928514;343.17466493084123;343.43676370751973;346.34886413542534;14638;15033.774493382582;17299;17543.38598149065;18429.63140737186;14716.558503244893;16052.75920861188;17891.73162402565;18294.451166464994;18318.633627327446;4846.9094453747975;5307.230451584518;5420.4850539198715;5435.239066530688;5439.048166570834;5257.553107985826;5392.676439413628;5394.703291318976;5400.675959442427;5408.2698835657075;5242.056429842627;5341.626086173969;5342.118550439173;5350.892982140354;5356.866078348034;5391.595630327722;5421.241026256327;5429.049916264638;5430.348358197002;5434.864128396782;4744.620430365597;4760;4761.523847615245;4764.785584648699;4766.142094423002;12659.873401266053;12821.423035963404;13044.608661740163;13050;13681.657958551115;1899.4681489183051;1930.536671198916;1951.365806113019;1986.1558837494008;1990.3929301563016;9221.123993220634;9277.396969197049;9313.254939604816;9646.228301735844;9663.758406039835;1465.124849354087;1514.174774747765;1551.2088834694275;1555.3623014564087;1612.6049117966056;47835.76082119602;50242.7487862562;54968.45031549713;57866.71066644682;60064;6378.266499352541;6495.415412612888;6550.475961923034;6610.140681711347;6629.370209830058;7543.924560754432;7548.886766698504;7555.546667199876;7558.508696934681;7567.394608431312;5527.088030475007;5529.806456773994;5538.16927460876;5574.16387541872;5580.38615752275;5924.822255332347;5927.792527261525;5947;5977.043673012297;5992.31088424828;2931.4430258250864;2953.867075981586;2963.555466679972;2979.6424429068215;2982.7166419190576;1045.7751583409604;1046.2257929132388;1051.2536099369534;1067.5836423794726;1095.7589330347312;443.17348145708024;443.59411138807627;451.44021413447746;453.4128303846461;453.74816976578313;11677.31421772997;11951.163418560618;12007.819882701766;12052.517899284107;12233.816492752616;468.6906641616517;473.8175802316133;480.80046780586366;485.06866815713914;488.05074130815933;6346.428821406095;6482.902756458657;6491.578047426902;6567.277599464055;6576.177977752781;545318;549928;556974;608377;621119;69280.65359673169;72956.63521682358;73354.63322683352;73819.26180738123;74480;480.1333592864843;483.76779146010114;491.7418355363463;493.767929073335;503.19740014676535;10644.787104258026;10701.197410194422;10852.945735271272;10915.78168436611;10948.890511095105;32361.35277294488;32984;33073.33853322968;33099.33801323912;34840.47739283862;37460.43809342916;38856.6114338853;42989.78505107579;44011.33982990194;44224.55775442333;6052.334243233153;6086.2087928569;6156.384361563808;6170.413810687977;6186.319504854552;11291.616226530004;11387.089032877515;11501.562304711912;11726.648200553997;11735.76528469443;10017.799644007226;10125.746856328356;10224.335418197794;10241.078302952472;10248.743781405525;9756.317057805885;9768.902310976799;9850.064243896819;9873.555689993824;10100.797984040131;9971.900280997388;10239.590416383558;10269.281150319406;10272.845907311246;10365.844512332473;6017.669028203491;6107.755689772359;6110.572259941761;6113.51091912637;6115;9756.365836220622;9766.853497197406;10044.246681498771;10205.59177632916;10208.183345332503 15:25:25 INFO - 2015-11-02 15:25:25,682 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1201.7476329970705;1679.1016806008784;1794.7666803315572;1805.3410505165618;1835.697109976853;7205.351518363346;7846.843063138734;7940.523568585889;7940.722074727386;7957.880631790527;7682.693942029854;7920.128785833568;7944.96027519863;7945.364370850332;7959.243871832181;1995.5609765851561;2031.7968203179712;2217.4345541886837;2218.8335874809372;2245.528439027806;2252.493189032471;2263.196565219348;2265.920692775753;2269.8638081715067;2271.681964524968;2197.7252843394576;2235.1394713035515;2238.2166241815316;2239.428945618873;2242.865428074321;2007.1670256843393;2047.2732180076082;2183.9017244224046;2237.2393386248755;2242.024719247133;2254.537819746948;2281.452451411666;2300.2524179641514;2302.3553405046614;2304.366299267698;7846.764597062097;7903.209679032108;7911.050673919109;7921.168277330912;7931.444798864082;4894.657373983822;4975.328330675385;4975.552200301954;4977.328060711794;4988.376452943382;2878.150945471091;2904.417092684492;2947.513660246057;2950.4246671898986;2962.525995840655;819.5084945399376;872.4808738800403;877.9385443018991;892.1212605583495;901.6078006067316;10385.01342372481;10388.792224155475;10393.37639741618;10403.635872744419;10410.947945260377;4364.170807546556;4435.689501734848;4486.75322857246;4495;4496.707713998645;9027.909720902708;9031.322650801216;9034.909650903406;9038.86441703375;9046.909530904739;4960.355153829979;4971.850844474671;4973.651844370859;4974.104661161025;4978.2034874419915;4541.2733962565835;4543.75046862109;4545.954540454619;4547.204239258117;4554.88612784683;3757.1546402059867;3829.9617003829603;3859.8842034739005;3887.5140607424073;3890.5604926177493;1220.8290839282508;1242.6458459339044;1251.7371352016178;1263.6335462715892;1266.0757646917618;1025.3335332034237;1060.612876300145;1061.654962137293;1201.4893670190133;1342.6978929740926;7514.962425187949;7532.435067369969;7577.583232922132;7577.659005344773;7592.734254301073;1055.5883205549842;1093.4587379247323;1166.854143232096;1169.0881112732084;1190.15498995714;6022.819315420545;6062.211912451353;6062.333143354227;6074;6083.543734219951;9105.408148470327;9456.33805633599;9461.621535138518;9464.763380915394;9469.10043545862;9382.90617093834;9408.106229908148;9411.576479058458;9420.34057615974;9435.716928492157;7061.9293807062295;7181.964090179516;7191.280871912872;7191.928080719231;7439.107307123071;7375.852482950204;7432.070991126109;7472;7478.70085196586;7487.438442116754;8269.131741167092;8439.324854011542;8491.065982742017;8494.617742201739;8498.957505212435;8435.620397082268;8615.138486151334;8654.870176947477;8657.480551166698;8659.13408659129;6967;7059.5764254144915;7061.71753129869;7061.788146355618;7066.516031633415;7524.209957954555;7534.35957943559;7606.923930760621;7609.847803044019;7613.238676132342;7097.9290207097265;7137.1435427749;7137.2149063604;7172.211056783854;7204.9279507204255;6325.683715814283;6561.835954101186;6899;6928.653567321715;7017.333353331425;7152.892706609509;7197.856042879218;7211.495195336276;7212.3148300911325;7239.493235473677;6440.25937017249;6509.056186852785;6515.185601799775;6524.217093948567;6543.574667646588;6571.737130514726;6596.736130554916;6599.6040237583975;6609.669516524058;6611.966940165268 15:25:25 INFO - 2015-11-02 15:25:25,682 DEBUG : BROWSER_OUTPUT: |4;prototype.html;319.7090647510765;331.65507871813315;332.5510560742997;333.7063384221884;337.7450025230952;6134.693265336727;6217.813465596028;6236.968815155924;6239.500839932806;6289.371062893714;6090.451859332659;6128.448439640431;6174.382561743823;6188.133661287412;6206.906896396557;4714.952850471503;4722.220833562458;4742.407199100121;4746.928796068062;4750.358701575295;4579.519150489201;4648.86053418398;4663.8367657132;4739.194336962724;4757.976210118962;4675.719456832601;4682.157211701892;4690.742009189493;4707.576318131368;4710.293455981613;4673.766311684436;4693.249080147177;4700.976495117519;4714.504976977402;4725.929111063337;4072.7149099563044;4079.469668943048;4079.9184016319805;4080.2859499587453;4087.264292427362;5785.4214578541805;6004.759809607611;6047.455728984369;6062.3634518375375;6074.726637301332;5397.433269506684;5410.1614249790955;5411.053065713484;5416.160495123262;5429.4299098594865;6256.87486250277;6505.60966342021;6522.282548919662;6543.869122617569;6545.280019197884;4384.342348647697;4395.318725597537;4456.732596044215;4463.553644635511;4470.351798989161;6660.200775906922;6739.393454589062;6763.323667633295;6769.695363708645;6776.119104516381;4507.57178068083;4530.592246697747;4538.591526762607;4549.909001819945;4554.4990051094355;4480.7535585542455;4576.06190730906;4595.655325850575;4661.463931647904;4693.178693728584;5387.568994480433;5388.380336261302;5397.487238712316;5405.486478784509;5413.756380962866;6515.804525864231;6534.346565343428;6547.9672601636685;6548;6556.541042127101;1673.564873132994;1697.73685078813;1699.422196453187;1699.7705309783269;1701.7617533545313;1102.6542249354911;1110.4114819145866;1111.3220935229504;1112.7551938573502;1121.8485504456958;6150.108234306001;6151.784687535915;6160.260768707783;6167;6167.537434692416;6787.524873258923;6793.082933803972;6797.456203503708;6802.4217941474535;6814.420774234147;6009.489193418521;6163.660998645118;6176.752929882754;6177.135201071854;6195.628262304276;3714.2757162353623;3742.7754334739457;3756.3238617048646;3757;3763.9811800941366;6833.111695479556;6844.247132815386;6844.726210951506;6851.554648947803;6858.794236172923;6808.285130061371;6936.34104760047;6938.063361446241;6960.095187625576;6994.195667498303;6804.727810887608;6807.081044059088;6809.012693159464;6813.216480104752;6837.794866154023;6575.50683698715;6618.702158402787;6650.800475985729;6753.088333074972;6762.053312536151;6589.308122647245;6612.603243805387;6615.735370585316;6630.336966303331;6637.070810086495;6803.489738269748;6807.455403567604;6810.557313774589;6814.011968264673;6823.727050917908;4393.055493069006;4444.688871778944;4483.260262056854;4484.39460672805;4491.573300536444;6697.732090716317;6711.63086030273;6722.058911752456;6724.831879203059;6730.966345168439;6480.481561475165;6505.577137486048;6512.120863683342;6524.739010439529;6540.084388185753;6494.383033611799;6501.902471462838;6526.641034743135;6582;6616.536842420985;6402.231732192166;6443.871122577616;6447.968325067966;6455.741770329134;6461;6565.277819439953;6566.704498297492;6576.112224849584;6578.901316480353;6581.6709164542535;6321.241451025906;6392.872142557216;6398.360163983564;6404.423601875854;6429.517786165963 15:25:25 INFO - 2015-11-02 15:25:25,686 DEBUG : BROWSER_OUTPUT: |5;yui.html;683.6718375179913;692.2661978302999;738.6306846576712;784.3725019984013;787.9093904201015;13745.999999999987;14072.155670659742;14097.295135243248;14126.22305773182;14141.15153090814;12069.577564785235;12833.260247244492;12986.54547090852;13137.27744974026;13158.407871645775;910.6311943662811;929.6420877961966;930.3766476460754;930.6044930904372;930.7347405989294;915.5010519267015;922.0687106022932;923.4274749655223;923.8106188231396;925.8981512033671;965.0976337124775;975.639013564982;976.3653625143643;976.3751199232497;976.716752141878;971.1793534463367;971.5385192033763;972.027972027972;972.2465089555616;972.5623469438781;724.807925899637;724.8369116948697;724.9021382113452;725.234877204549;725.8004048886546;10933.125349971982;10974.615888443946;10979.945100274528;10996.06533444658;11006.229563930528;10217.489125543767;10253.179745620333;10308.175345972304;10487;10821.567137314498;8769.386142969995;8878.556072196365;8931.37480376374;8983.28133749305;9160.038195989458;3326.76712630116;3335.1328654549748;3372.561566996275;3383.171123074838;3481.477778333245;47368.70845557748;47682.5231747685;47878;47889.52110478885;48220.51779482196;6295;7783.922160778433;7938.56337901421;7954.642041108048;8016.438849280495;11944.88055119455;12063.517459301705;12075.09436792244;12089.093318001009;12089.274643521418;5935.703214839241;6045.33501314855;6093.055576385667;6215.440610345;6215.658138802319;3649.5620525536574;3699.611540788232;3704.944425833615;3708.9443658345144;3720.925581488409;2587.159173268695;2616.136674897279;2624.553825849572;2626.566616508255;2627.894884204649;406.28696637401174;413.78276404887674;417.0636920114363;419.9769012704331;423.3205704843743;482.11772456404697;483.70977413552293;521.2244796458872;554.9611527193058;567.5629765080864;7909.3277071449575;8528.061913189544;8538.78653033679;8574.742757717278;8617.310615150773;469.98590042298787;476.46397802472217;477.33888564337946;573.2519062623234;620.8447888027993;3844.4041173618134;3847.461355410245;3868.6131386861653;3963.742356746802;3970.841166353371;59966.400335996084;61015.694921525996;61062;61218;61276;45168.3224751629;45492.77253613777;49894.75052624786;52692.473075269525;52709.47290527046;42112.78943605324;43779;44011.77994110009;45856;47582.28626570604;6895.6552172392185;8234.176582341717;8392.83214335722;8442.873356899529;8450.535220562928;35744.10639734028;35979.82010089933;36429.45355819612;36455.635443645224;36638.63361366352;45824.312635311166;45933.77033114813;46067.078658427316;46514.534854652375;47343.76328118475;7212.386947109345;7321.560706357635;7362.116546014512;7371.926280737124;7416.110066792019;10839.67480975572;11148.77175817528;11187.944060279646;11256.831147532957;11485.253458525169;10445.843312350169;10645.254832161674;10857.619983300547;10923.617673381394;10962.451877406258;10086.949565252127;10455.84316235242;10564.313319634199;10601.946990265;10683.679489615324;10165.237607179342;10735.194860385658;10757.677269681923;10962.397068161328;11319;8961.731148065568;9059.184673379428;9088;9205.401648893068;9978.151857091938;8215.301699355621;8614.353923455641;8658.653653854028;8739.43193692408;9425.528723563932 15:25:25 INFO - 2015-11-02 15:25:25,686 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:25:25 INFO - 2015-11-02 15:25:25,686 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:25:25 INFO - 2015-11-02 15:25:25,686 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1004 15:25:25 INFO - 2015-11-02 15:25:25,686 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:25:25 INFO - 2015-11-02 15:25:25,687 DEBUG : BROWSER_OUTPUT: __startTimestamp1446506725671__endTimestamp 15:25:25 INFO - 2015-11-02 15:25:25,687 DEBUG : BROWSER_OUTPUT: 15:25:25 INFO - 2015-11-02 15:25:25,687 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:25:25 INFO - 2015-11-02 15:25:25,687 DEBUG : BROWSER_OUTPUT: Number of tests: 6 15:25:25 INFO - 2015-11-02 15:25:25,687 DEBUG : BROWSER_OUTPUT: 15:25:25 INFO - 2015-11-02 15:25:25,687 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5419.56 Median:5592.80 stddev:564.47 (10.1%) stddev-sans-first:538.55 15:25:25 INFO - 2015-11-02 15:25:25,688 DEBUG : BROWSER_OUTPUT: Values: 3194.7 3257.0 3282.1 3294.6 3320.0 5263.5 5403.3 5450.3 5476.3 5482.9 5412.9 5418.3 5438.5 5481.2 5592.8 4996.2 5030.1 5049.5 5101.0 5101.6 5047.0 5075.2 5109.4 5121.5 5122.7 4820.1 4846.5 4992.1 5063.6 5085.2 5021.6 5063.4 5073.7 5091.4 5116.5 5022.2 5036.0 5049.4 5053.6 5055.0 5216.2 5323.2 5328.8 5336.8 5482.0 5815.1 5818.8 5819.6 5826.5 5834.7 5914.7 5924.4 5928.0 5933.1 5951.2 5339.7 5392.3 5447.0 5455.2 5489.1 5924.3 5975.4 5981.4 5998.9 6005.5 5697.5 5701.9 5716.4 5721.7 5735.3 5652.5 5654.0 5782.0 5792.0 5798.6 5700.7 5701.7 5721.2 5733.6 5854.1 5727.6 5739.2 5740.5 5745.5 5747.0 4410.5 4497.7 4564.1 4566.2 4569.6 4116.8 4149.3 4151.3 4173.3 4189.3 5344.9 5376.3 5384.8 5392.5 5424.8 5717.6 5734.8 5807.4 5814.4 5819.4 5453.0 5460.8 5464.8 5465.0 5489.9 5178.3 5185.7 5195.8 5211.9 5246.4 5677.3 5775.7 5780.5 5860.1 5943.6 5823.5 5843.1 5845.4 5870.3 5886.6 5862.8 5869.6 5886.5 5888.8 5893.9 5683.2 5777.1 5781.4 5794.6 5810.6 5817.7 5852.2 5940.5 5953.3 5992.9 5786.3 5818.9 5826.4 5841.1 5852.3 5468.8 5612.6 5807.7 5825.7 5831.4 5400.6 5454.7 5469.5 5505.6 5571.6 5613.1 5731.5 5742.4 5758.0 5784.7 5353.3 5434.0 5673.5 5679.2 5679.8 15:25:25 INFO - 2015-11-02 15:25:25,688 DEBUG : BROWSER_OUTPUT: 15:25:25 INFO - 2015-11-02 15:25:25,688 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:49120.18 Median:17374.57 stddev:85229.66 (490.5%) stddev-sans-first:85390.76 15:25:25 INFO - 2015-11-02 15:25:25,688 DEBUG : BROWSER_OUTPUT: Values: 560.2 562.1 573.3 582.0 586.4 31476.1 32055.4 38928.2 40027.0 40034.0 42679.8 43127.8 43203.8 43211.4 43245.6 8252.1 9261.9 9491.0 9497.3 9512.7 8402.5 11261.3 11393.3 11487.1 11497.0 11234.6 11322.9 11359.0 11361.7 11367.1 8460.9 8654.6 11087.2 11223.3 11279.2 10955.7 11108.3 11120.6 11150.7 11163.0 39781.4 40259.8 40270.0 40298.8 40331.8 3160.8 3242.0 3252.3 3404.4 3467.7 27599.9 28240.9 28364.0 28381.0 28479.6 2343.9 2369.5 2370.0 2392.9 2469.3 292217.0 293664.0 294743.0 295294.0 296337.0 49848.5 51438.7 59909.0 60413.4 63932.0 60419.4 60533.7 60757.7 60908.0 60909.0 16755.4 16931.6 16933.2 16934.5 16958.3 12864.4 12934.0 12947.2 12955.7 12959.5 19140.0 19171.0 19189.0 19206.7 19310.4 7971.0 8226.8 8234.5 8250.8 8279.2 965.1 1030.5 1039.0 1061.8 1168.3 28876.6 28922.6 29247.3 29404.1 29435.6 1005.6 1045.9 1136.7 1171.3 1277.5 15182.2 15233.9 15426.8 15448.2 15737.8 340679.0 348081.0 348427.0 350152.0 350296.0 56293.7 56498.2 56505.0 56572.7 56602.7 1398.4 1400.9 1410.5 1412.4 1414.8 28877.7 28952.7 29038.3 29439.4 29650.9 43243.4 44055.0 46984.5 47375.0 47430.5 327234.0 330554.0 333276.0 334181.3 334627.0 29606.9 29934.0 29955.1 30001.5 30025.5 38042.0 41310.8 41401.4 41425.4 41648.6 33880.8 35120.5 35406.5 35502.0 37616.8 34899.5 35154.6 35814.3 35817.3 35879.1 34893.5 35381.3 35495.3 35722.6 36195.5 29630.4 31352.2 31548.4 31588.4 31605.2 24197.4 24312.3 24331.0 24632.3 24708.5 15:25:25 INFO - 2015-11-02 15:25:25,688 DEBUG : BROWSER_OUTPUT: 15:25:25 INFO - 2015-11-02 15:25:25,690 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27459.91 Median:24157.95 stddev:94425.83 (390.9%) stddev-sans-first:94668.76 15:25:25 INFO - 2015-11-02 15:25:25,690 DEBUG : BROWSER_OUTPUT: Values: 341.2 342.8 343.2 343.4 346.3 14638.0 15033.8 17299.0 17543.4 18429.6 14716.6 16052.8 17891.7 18294.5 18318.6 4846.9 5307.2 5420.5 5435.2 5439.0 5257.6 5392.7 5394.7 5400.7 5408.3 5242.1 5341.6 5342.1 5350.9 5356.9 5391.6 5421.2 5429.0 5430.3 5434.9 4744.6 4760.0 4761.5 4764.8 4766.1 12659.9 12821.4 13044.6 13050.0 13681.7 1899.5 1930.5 1951.4 1986.2 1990.4 9221.1 9277.4 9313.3 9646.2 9663.8 1465.1 1514.2 1551.2 1555.4 1612.6 47835.8 50242.7 54968.5 57866.7 60064.0 6378.3 6495.4 6550.5 6610.1 6629.4 7543.9 7548.9 7555.5 7558.5 7567.4 5527.1 5529.8 5538.2 5574.2 5580.4 5924.8 5927.8 5947.0 5977.0 5992.3 2931.4 2953.9 2963.6 2979.6 2982.7 1045.8 1046.2 1051.3 1067.6 1095.8 443.2 443.6 451.4 453.4 453.7 11677.3 11951.2 12007.8 12052.5 12233.8 468.7 473.8 480.8 485.1 488.1 6346.4 6482.9 6491.6 6567.3 6576.2 545318.0 549928.0 556974.0 608377.0 621119.0 69280.7 72956.6 73354.6 73819.3 74480.0 480.1 483.8 491.7 493.8 503.2 10644.8 10701.2 10852.9 10915.8 10948.9 32361.4 32984.0 33073.3 33099.3 34840.5 37460.4 38856.6 42989.8 44011.3 44224.6 6052.3 6086.2 6156.4 6170.4 6186.3 11291.6 11387.1 11501.6 11726.6 11735.8 10017.8 10125.7 10224.3 10241.1 10248.7 9756.3 9768.9 9850.1 9873.6 10100.8 9971.9 10239.6 10269.3 10272.8 10365.8 6017.7 6107.8 6110.6 6113.5 6115.0 9756.4 9766.9 10044.2 10205.6 10208.2 15:25:25 INFO - 2015-11-02 15:25:25,690 DEBUG : BROWSER_OUTPUT: 15:25:25 INFO - 2015-11-02 15:25:25,690 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5522.07 Median:6552.71 stddev:2835.21 (43.3%) stddev-sans-first:2824.56 15:25:25 INFO - 2015-11-02 15:25:25,691 DEBUG : BROWSER_OUTPUT: Values: 1201.7 1679.1 1794.8 1805.3 1835.7 7205.4 7846.8 7940.5 7940.7 7957.9 7682.7 7920.1 7945.0 7945.4 7959.2 1995.6 2031.8 2217.4 2218.8 2245.5 2252.5 2263.2 2265.9 2269.9 2271.7 2197.7 2235.1 2238.2 2239.4 2242.9 2007.2 2047.3 2183.9 2237.2 2242.0 2254.5 2281.5 2300.3 2302.4 2304.4 7846.8 7903.2 7911.1 7921.2 7931.4 4894.7 4975.3 4975.6 4977.3 4988.4 2878.2 2904.4 2947.5 2950.4 2962.5 819.5 872.5 877.9 892.1 901.6 10385.0 10388.8 10393.4 10403.6 10410.9 4364.2 4435.7 4486.8 4495.0 4496.7 9027.9 9031.3 9034.9 9038.9 9046.9 4960.4 4971.9 4973.7 4974.1 4978.2 4541.3 4543.8 4546.0 4547.2 4554.9 3757.2 3830.0 3859.9 3887.5 3890.6 1220.8 1242.6 1251.7 1263.6 1266.1 1025.3 1060.6 1061.7 1201.5 1342.7 7515.0 7532.4 7577.6 7577.7 7592.7 1055.6 1093.5 1166.9 1169.1 1190.2 6022.8 6062.2 6062.3 6074.0 6083.5 9105.4 9456.3 9461.6 9464.8 9469.1 9382.9 9408.1 9411.6 9420.3 9435.7 7061.9 7182.0 7191.3 7191.9 7439.1 7375.9 7432.1 7472.0 7478.7 7487.4 8269.1 8439.3 8491.1 8494.6 8499.0 8435.6 8615.1 8654.9 8657.5 8659.1 6967.0 7059.6 7061.7 7061.8 7066.5 7524.2 7534.4 7606.9 7609.8 7613.2 7097.9 7137.1 7137.2 7172.2 7204.9 6325.7 6561.8 6899.0 6928.7 7017.3 7152.9 7197.9 7211.5 7212.3 7239.5 6440.3 6509.1 6515.2 6524.2 6543.6 6571.7 6596.7 6599.6 6609.7 6612.0 15:25:25 INFO - 2015-11-02 15:25:25,691 DEBUG : BROWSER_OUTPUT: 15:25:25 INFO - 2015-11-02 15:25:25,692 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5436.66 Median:6175.57 stddev:1634.57 (26.5%) stddev-sans-first:1593.39 15:25:25 INFO - 2015-11-02 15:25:25,693 DEBUG : BROWSER_OUTPUT: Values: 319.7 331.7 332.6 333.7 337.7 6134.7 6217.8 6237.0 6239.5 6289.4 6090.5 6128.4 6174.4 6188.1 6206.9 4715.0 4722.2 4742.4 4746.9 4750.4 4579.5 4648.9 4663.8 4739.2 4758.0 4675.7 4682.2 4690.7 4707.6 4710.3 4673.8 4693.2 4701.0 4714.5 4725.9 4072.7 4079.5 4079.9 4080.3 4087.3 5785.4 6004.8 6047.5 6062.4 6074.7 5397.4 5410.2 5411.1 5416.2 5429.4 6256.9 6505.6 6522.3 6543.9 6545.3 4384.3 4395.3 4456.7 4463.6 4470.4 6660.2 6739.4 6763.3 6769.7 6776.1 4507.6 4530.6 4538.6 4549.9 4554.5 4480.8 4576.1 4595.7 4661.5 4693.2 5387.6 5388.4 5397.5 5405.5 5413.8 6515.8 6534.3 6548.0 6548.0 6556.5 1673.6 1697.7 1699.4 1699.8 1701.8 1102.7 1110.4 1111.3 1112.8 1121.8 6150.1 6151.8 6160.3 6167.0 6167.5 6787.5 6793.1 6797.5 6802.4 6814.4 6009.5 6163.7 6176.8 6177.1 6195.6 3714.3 3742.8 3756.3 3757.0 3764.0 6833.1 6844.2 6844.7 6851.6 6858.8 6808.3 6936.3 6938.1 6960.1 6994.2 6804.7 6807.1 6809.0 6813.2 6837.8 6575.5 6618.7 6650.8 6753.1 6762.1 6589.3 6612.6 6615.7 6630.3 6637.1 6803.5 6807.5 6810.6 6814.0 6823.7 4393.1 4444.7 4483.3 4484.4 4491.6 6697.7 6711.6 6722.1 6724.8 6731.0 6480.5 6505.6 6512.1 6524.7 6540.1 6494.4 6501.9 6526.6 6582.0 6616.5 6402.2 6443.9 6448.0 6455.7 6461.0 6565.3 6566.7 6576.1 6578.9 6581.7 6321.2 6392.9 6398.4 6404.4 6429.5 15:25:25 INFO - 2015-11-02 15:25:25,693 DEBUG : BROWSER_OUTPUT: 15:25:25 INFO - 2015-11-02 15:25:25,693 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13152.69 Median:24079.93 stddev:16241.65 (67.4%) stddev-sans-first:16260.22 15:25:25 INFO - 2015-11-02 15:25:25,694 DEBUG : BROWSER_OUTPUT: Values: 683.7 692.3 738.6 784.4 787.9 13746.0 14072.2 14097.3 14126.2 14141.2 12069.6 12833.3 12986.5 13137.3 13158.4 910.6 929.6 930.4 930.6 930.7 915.5 922.1 923.4 923.8 925.9 965.1 975.6 976.4 976.4 976.7 971.2 971.5 972.0 972.2 972.6 724.8 724.8 724.9 725.2 725.8 10933.1 10974.6 10979.9 10996.1 11006.2 10217.5 10253.2 10308.2 10487.0 10821.6 8769.4 8878.6 8931.4 8983.3 9160.0 3326.8 3335.1 3372.6 3383.2 3481.5 47368.7 47682.5 47878.0 47889.5 48220.5 6295.0 7783.9 7938.6 7954.6 8016.4 11944.9 12063.5 12075.1 12089.1 12089.3 5935.7 6045.3 6093.1 6215.4 6215.7 3649.6 3699.6 3704.9 3708.9 3720.9 2587.2 2616.1 2624.6 2626.6 2627.9 406.3 413.8 417.1 420.0 423.3 482.1 483.7 521.2 555.0 567.6 7909.3 8528.1 8538.8 8574.7 8617.3 470.0 476.5 477.3 573.3 620.8 3844.4 3847.5 3868.6 3963.7 3970.8 59966.4 61015.7 61062.0 61218.0 61276.0 45168.3 45492.8 49894.8 52692.5 52709.5 42112.8 43779.0 44011.8 45856.0 47582.3 6895.7 8234.2 8392.8 8442.9 8450.5 35744.1 35979.8 36429.5 36455.6 36638.6 45824.3 45933.8 46067.1 46514.5 47343.8 7212.4 7321.6 7362.1 7371.9 7416.1 10839.7 11148.8 11187.9 11256.8 11485.3 10445.8 10645.3 10857.6 10923.6 10962.5 10086.9 10455.8 10564.3 10601.9 10683.7 10165.2 10735.2 10757.7 10962.4 11319.0 8961.7 9059.2 9088.0 9205.4 9978.2 8215.3 8614.4 8658.7 8739.4 9425.5 15:25:25 INFO - 2015-11-02 15:25:25,695 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:25:25 INFO - 2015-11-02 15:25:25,695 DEBUG : BROWSER_OUTPUT: 15:25:26 INFO - 2015-11-02 15:25:26,098 INFO : Browser exited with error code: 0 15:25:26 INFO - 2015-11-02 15:25:26,125 INFO : Completed test dromaeo_css (00:18:34) 15:25:26 INFO - 2015-11-02 15:25:26,125 INFO : Starting test kraken 15:25:26 INFO - 2015-11-02 15:25:26,125 DEBUG : operating with platform_type : mac_ 15:25:26 INFO - 2015-11-02 15:25:26,125 INFO : Initialising browser for kraken test... 15:25:26 INFO - 2015-11-02 15:25:26,137 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/T/tmpHQcQNF/profile http://localhost:49265/getInfo.html 15:25:28 INFO - 2015-11-02 15:25:28,285 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:25:28 INFO - 2015-11-02 15:25:28,285 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:25:28 INFO - 2015-11-02 15:25:28,285 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 15:25:28 INFO - 2015-11-02 15:25:28,285 DEBUG : BROWSER_OUTPUT: __metrics 15:25:28 INFO - 2015-11-02 15:25:28,302 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:25:28 INFO - 2015-11-02 15:25:28,963 INFO : Browser initialized. 15:25:28 INFO - 2015-11-02 15:25:28,963 INFO : Running cycle 1/1 for kraken test... 15:25:28 INFO - 2015-11-02 15:25:28,963 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/T/tmpHQcQNF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:25:40 INFO - 2015-11-02 15:25:40,814 DEBUG : BROWSER_OUTPUT: RSS: Main: 221605888 15:25:40 INFO - 2015-11-02 15:25:40,814 DEBUG : BROWSER_OUTPUT: 15:25:43 INFO - 2015-11-02 15:25:43,387 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-beat-detection) 15:25:43 INFO - 2015-11-02 15:25:43,979 DEBUG : BROWSER_OUTPUT: RSS: Main: 277585920 15:25:43 INFO - 2015-11-02 15:25:43,979 DEBUG : BROWSER_OUTPUT: 15:25:46 INFO - 2015-11-02 15:25:46,608 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-dft) 15:25:47 INFO - 2015-11-02 15:25:47,195 DEBUG : BROWSER_OUTPUT: RSS: Main: 289353728 15:25:47 INFO - 2015-11-02 15:25:47,195 DEBUG : BROWSER_OUTPUT: 15:25:50 INFO - 2015-11-02 15:25:50,166 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-fft) 15:25:50 INFO - 2015-11-02 15:25:50,749 DEBUG : BROWSER_OUTPUT: RSS: Main: 270942208 15:25:50 INFO - 2015-11-02 15:25:50,750 DEBUG : BROWSER_OUTPUT: 15:25:52 INFO - 2015-11-02 15:25:52,751 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-oscillator) 15:25:53 INFO - 2015-11-02 15:25:53,332 DEBUG : BROWSER_OUTPUT: RSS: Main: 273096704 15:25:53 INFO - 2015-11-02 15:25:53,332 DEBUG : BROWSER_OUTPUT: 15:25:55 INFO - 2015-11-02 15:25:55,509 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49265/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:25:56 INFO - 2015-11-02 15:25:56,084 DEBUG : BROWSER_OUTPUT: RSS: Main: 273924096 15:25:56 INFO - 2015-11-02 15:25:56,084 DEBUG : BROWSER_OUTPUT: 15:25:59 INFO - 2015-11-02 15:25:59,124 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49265/tests/kraken/driver.html?testName=imaging-darkroom) 15:25:59 INFO - 2015-11-02 15:25:59,710 DEBUG : BROWSER_OUTPUT: RSS: Main: 275603456 15:25:59 INFO - 2015-11-02 15:25:59,710 DEBUG : BROWSER_OUTPUT: 15:26:02 INFO - 2015-11-02 15:26:02,826 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49265/tests/kraken/driver.html?testName=imaging-desaturate) 15:26:03 INFO - 2015-11-02 15:26:03,408 DEBUG : BROWSER_OUTPUT: RSS: Main: 276316160 15:26:03 INFO - 2015-11-02 15:26:03,408 DEBUG : BROWSER_OUTPUT: 15:26:06 INFO - 2015-11-02 15:26:06,270 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49265/tests/kraken/driver.html?testName=json-parse-financial) 15:26:06 INFO - 2015-11-02 15:26:06,859 DEBUG : BROWSER_OUTPUT: RSS: Main: 275832832 15:26:06 INFO - 2015-11-02 15:26:06,859 DEBUG : BROWSER_OUTPUT: 15:26:08 INFO - 2015-11-02 15:26:08,404 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49265/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:26:08 INFO - 2015-11-02 15:26:08,977 DEBUG : BROWSER_OUTPUT: RSS: Main: 309415936 15:26:08 INFO - 2015-11-02 15:26:08,977 DEBUG : BROWSER_OUTPUT: 15:26:10 INFO - 2015-11-02 15:26:10,781 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:26:11 INFO - 2015-11-02 15:26:11,388 DEBUG : BROWSER_OUTPUT: RSS: Main: 310534144 15:26:11 INFO - 2015-11-02 15:26:11,388 DEBUG : BROWSER_OUTPUT: 15:26:13 INFO - 2015-11-02 15:26:13,474 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:26:14 INFO - 2015-11-02 15:26:14,056 DEBUG : BROWSER_OUTPUT: RSS: Main: 318750720 15:26:14 INFO - 2015-11-02 15:26:14,056 DEBUG : BROWSER_OUTPUT: 15:26:16 INFO - 2015-11-02 15:26:16,572 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:26:17 INFO - 2015-11-02 15:26:17,160 DEBUG : BROWSER_OUTPUT: RSS: Main: 320684032 15:26:17 INFO - 2015-11-02 15:26:17,160 DEBUG : BROWSER_OUTPUT: 15:26:19 INFO - 2015-11-02 15:26:19,724 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:26:20 INFO - 2015-11-02 15:26:20,306 DEBUG : BROWSER_OUTPUT: RSS: Main: 318820352 15:26:20 INFO - 2015-11-02 15:26:20,306 DEBUG : BROWSER_OUTPUT: 15:26:22 INFO - 2015-11-02 15:26:22,025 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49265/tests/kraken/driver.html?testName=ai-astar) 15:26:22 INFO - 2015-11-02 15:26:22,271 DEBUG : BROWSER_OUTPUT: RSS: Main: 378994688 15:26:22 INFO - 2015-11-02 15:26:22,271 DEBUG : BROWSER_OUTPUT: 15:26:22 INFO - 2015-11-02 15:26:22,272 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:26:22 INFO - 2015-11-02 15:26:22,272 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:26:22 INFO - 2015-11-02 15:26:22,272 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:26:22 INFO - 2015-11-02 15:26:22,272 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:26:22 INFO - 2015-11-02 15:26:22,272 DEBUG : BROWSER_OUTPUT: |0;ai-astar;105;104;106;108;108;107;114;108;107;108 15:26:22 INFO - 2015-11-02 15:26:22,272 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;157;129;147;163;126;149;147;126;164;125 15:26:22 INFO - 2015-11-02 15:26:22,273 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;160;161;162;163;163;162;163;163;160 15:26:22 INFO - 2015-11-02 15:26:22,273 DEBUG : BROWSER_OUTPUT: |3;audio-fft;77;81;87;84;68;70;69;77;82;66 15:26:22 INFO - 2015-11-02 15:26:22,273 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;100;97;133;88;89;92;125;87;89;130 15:26:22 INFO - 2015-11-02 15:26:22,273 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;120;120;120;114;115;115;114;120;120;120 15:26:22 INFO - 2015-11-02 15:26:22,273 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;125;125;125;125;124;125;125;124;125;125 15:26:22 INFO - 2015-11-02 15:26:22,273 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;101;101;101;100;101;101;100;100;100;102 15:26:22 INFO - 2015-11-02 15:26:22,274 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;56;58;57;56;57;57;66;56;55 15:26:22 INFO - 2015-11-02 15:26:22,274 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;65;66;66;67;68;67;66;66;67;67 15:26:22 INFO - 2015-11-02 15:26:22,274 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;86;85;85;85;85;85;86;87;88 15:26:22 INFO - 2015-11-02 15:26:22,274 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;129;121;130;120;124;120;122;123;119;121 15:26:22 INFO - 2015-11-02 15:26:22,274 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;149;147;147;137;150;146;147;148;145;136 15:26:22 INFO - 2015-11-02 15:26:22,274 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;69;68;69;71;69;71;70;70;70 15:26:22 INFO - 2015-11-02 15:26:22,275 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:26:22 INFO - 2015-11-02 15:26:22,275 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:26:22 INFO - 2015-11-02 15:26:22,275 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,917 15:26:22 INFO - 2015-11-02 15:26:22,275 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:26:22 INFO - 2015-11-02 15:26:22,277 DEBUG : BROWSER_OUTPUT: __startTimestamp1446506782270__endTimestamp 15:26:22 INFO - 2015-11-02 15:26:22,277 DEBUG : BROWSER_OUTPUT: 15:26:22 INFO - 2015-11-02 15:26:22,277 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:26:22 INFO - 2015-11-02 15:26:22,277 DEBUG : BROWSER_OUTPUT: Number of tests: 14 15:26:22 INFO - 2015-11-02 15:26:22,277 DEBUG : BROWSER_OUTPUT: 15:26:22 INFO - 2015-11-02 15:26:22,277 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.50 Median:108.00 stddev:2.68 (2.5%) stddev-sans-first:2.68 15:26:22 INFO - 2015-11-02 15:26:22,278 DEBUG : BROWSER_OUTPUT: Values: 105.0 104.0 106.0 108.0 108.0 107.0 114.0 108.0 107.0 108.0 15:26:22 INFO - 2015-11-02 15:26:22,278 DEBUG : BROWSER_OUTPUT: 15:26:22 INFO - 2015-11-02 15:26:22,278 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.30 Median:148.00 stddev:15.64 (10.6%) stddev-sans-first:15.79 15:26:22 INFO - 2015-11-02 15:26:22,278 DEBUG : BROWSER_OUTPUT: Values: 157.0 129.0 147.0 163.0 126.0 149.0 147.0 126.0 164.0 125.0 15:26:22 INFO - 2015-11-02 15:26:22,278 DEBUG : BROWSER_OUTPUT: 15:26:22 INFO - 2015-11-02 15:26:22,278 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.90 Median:162.50 stddev:1.20 (0.7%) stddev-sans-first:1.27 15:26:22 INFO - 2015-11-02 15:26:22,278 DEBUG : BROWSER_OUTPUT: Values: 162.0 160.0 161.0 162.0 163.0 163.0 162.0 163.0 163.0 160.0 15:26:22 INFO - 2015-11-02 15:26:22,279 DEBUG : BROWSER_OUTPUT: 15:26:22 INFO - 2015-11-02 15:26:22,279 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:76.10 Median:79.00 stddev:7.43 (9.4%) stddev-sans-first:7.87 15:26:22 INFO - 2015-11-02 15:26:22,279 DEBUG : BROWSER_OUTPUT: Values: 77.0 81.0 87.0 84.0 68.0 70.0 69.0 77.0 82.0 66.0 15:26:22 INFO - 2015-11-02 15:26:22,279 DEBUG : BROWSER_OUTPUT: 15:26:22 INFO - 2015-11-02 15:26:22,279 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.00 Median:88.50 stddev:18.71 (21.1%) stddev-sans-first:19.82 15:26:22 INFO - 2015-11-02 15:26:22,279 DEBUG : BROWSER_OUTPUT: Values: 100.0 97.0 133.0 88.0 89.0 92.0 125.0 87.0 89.0 130.0 15:26:22 INFO - 2015-11-02 15:26:22,279 DEBUG : BROWSER_OUTPUT: 15:26:22 INFO - 2015-11-02 15:26:22,280 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:120.00 stddev:2.86 (2.4%) stddev-sans-first:2.92 15:26:22 INFO - 2015-11-02 15:26:22,280 DEBUG : BROWSER_OUTPUT: Values: 120.0 120.0 120.0 114.0 115.0 115.0 114.0 120.0 120.0 120.0 15:26:22 INFO - 2015-11-02 15:26:22,280 DEBUG : BROWSER_OUTPUT: 15:26:22 INFO - 2015-11-02 15:26:22,280 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:124.80 Median:125.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 15:26:22 INFO - 2015-11-02 15:26:22,280 DEBUG : BROWSER_OUTPUT: Values: 125.0 125.0 125.0 125.0 124.0 125.0 125.0 124.0 125.0 125.0 15:26:22 INFO - 2015-11-02 15:26:22,280 DEBUG : BROWSER_OUTPUT: 15:26:22 INFO - 2015-11-02 15:26:22,281 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:100.70 Median:101.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 15:26:22 INFO - 2015-11-02 15:26:22,282 DEBUG : BROWSER_OUTPUT: Values: 101.0 101.0 101.0 100.0 101.0 101.0 100.0 100.0 100.0 102.0 15:26:22 INFO - 2015-11-02 15:26:22,282 DEBUG : BROWSER_OUTPUT: 15:26:22 INFO - 2015-11-02 15:26:22,282 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:57.60 Median:57.00 stddev:3.10 (5.4%) stddev-sans-first:3.28 15:26:22 INFO - 2015-11-02 15:26:22,282 DEBUG : BROWSER_OUTPUT: Values: 58.0 56.0 58.0 57.0 56.0 57.0 57.0 66.0 56.0 55.0 15:26:22 INFO - 2015-11-02 15:26:22,282 DEBUG : BROWSER_OUTPUT: 15:26:22 INFO - 2015-11-02 15:26:22,283 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:67.00 stddev:0.85 (1.3%) stddev-sans-first:0.71 15:26:22 INFO - 2015-11-02 15:26:22,283 DEBUG : BROWSER_OUTPUT: Values: 65.0 66.0 66.0 67.0 68.0 67.0 66.0 66.0 67.0 67.0 15:26:22 INFO - 2015-11-02 15:26:22,283 DEBUG : BROWSER_OUTPUT: 15:26:22 INFO - 2015-11-02 15:26:22,283 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:85.50 stddev:1.06 (1.2%) stddev-sans-first:1.09 15:26:22 INFO - 2015-11-02 15:26:22,283 DEBUG : BROWSER_OUTPUT: Values: 85.0 86.0 85.0 85.0 85.0 85.0 85.0 86.0 87.0 88.0 15:26:22 INFO - 2015-11-02 15:26:22,283 DEBUG : BROWSER_OUTPUT: 15:26:22 INFO - 2015-11-02 15:26:22,284 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.90 Median:122.50 stddev:3.78 (3.1%) stddev-sans-first:3.31 15:26:22 INFO - 2015-11-02 15:26:22,284 DEBUG : BROWSER_OUTPUT: Values: 129.0 121.0 130.0 120.0 124.0 120.0 122.0 123.0 119.0 121.0 15:26:22 INFO - 2015-11-02 15:26:22,284 DEBUG : BROWSER_OUTPUT: 15:26:22 INFO - 2015-11-02 15:26:22,284 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.20 Median:147.00 stddev:4.80 (3.3%) stddev-sans-first:4.89 15:26:22 INFO - 2015-11-02 15:26:22,284 DEBUG : BROWSER_OUTPUT: Values: 149.0 147.0 147.0 137.0 150.0 146.0 147.0 148.0 145.0 136.0 15:26:22 INFO - 2015-11-02 15:26:22,284 DEBUG : BROWSER_OUTPUT: 15:26:22 INFO - 2015-11-02 15:26:22,284 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:70.00 stddev:0.97 (1.4%) stddev-sans-first:1.00 15:26:22 INFO - 2015-11-02 15:26:22,285 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 68.0 69.0 71.0 69.0 71.0 70.0 70.0 70.0 15:26:22 INFO - 2015-11-02 15:26:22,285 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:26:22 INFO - 2015-11-02 15:26:22,285 DEBUG : BROWSER_OUTPUT: 15:26:22 INFO - 2015-11-02 15:26:22,898 INFO : Browser exited with error code: 0 15:26:22 INFO - 2015-11-02 15:26:22,946 INFO : Completed test kraken (00:00:56) 15:26:22 INFO - 2015-11-02 15:26:22,946 INFO : Starting test v8_7 15:26:22 INFO - 2015-11-02 15:26:22,946 DEBUG : operating with platform_type : mac_ 15:26:22 INFO - 2015-11-02 15:26:22,946 INFO : Initialising browser for v8_7 test... 15:26:22 INFO - 2015-11-02 15:26:22,959 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/T/tmp92ZbGG/profile http://localhost:49265/getInfo.html 15:26:25 INFO - 2015-11-02 15:26:25,052 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:26:25 INFO - 2015-11-02 15:26:25,052 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:26:25 INFO - 2015-11-02 15:26:25,052 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 15:26:25 INFO - 2015-11-02 15:26:25,052 DEBUG : BROWSER_OUTPUT: __metrics 15:26:25 INFO - 2015-11-02 15:26:25,061 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:26:25 INFO - 2015-11-02 15:26:25,723 INFO : Browser initialized. 15:26:25 INFO - 2015-11-02 15:26:25,724 INFO : Running cycle 1/1 for v8_7 test... 15:26:25 INFO - 2015-11-02 15:26:25,724 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/T/tmp92ZbGG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:26:37 INFO - 2015-11-02 15:26:37,544 DEBUG : BROWSER_OUTPUT: RSS: Main: 220860416 15:26:37 INFO - 2015-11-02 15:26:37,545 DEBUG : BROWSER_OUTPUT: 15:26:59 INFO - 2015-11-02 15:26:59,075 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/v8_7/run.html (next: http://localhost:49265/tests/v8_7/run.html) 15:26:59 INFO - 2015-11-02 15:26:59,335 DEBUG : BROWSER_OUTPUT: RSS: Main: 753254400 15:26:59 INFO - 2015-11-02 15:26:59,335 DEBUG : BROWSER_OUTPUT: 15:26:59 INFO - 2015-11-02 15:26:59,336 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:26:59 INFO - 2015-11-02 15:26:59,336 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:26:59 INFO - 2015-11-02 15:26:59,336 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:26:59 INFO - 2015-11-02 15:26:59,336 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:26:59 INFO - 2015-11-02 15:26:59,336 DEBUG : BROWSER_OUTPUT: |0;Richards;168.83336147222693 15:26:59 INFO - 2015-11-02 15:26:59,336 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.27773527161438 15:26:59 INFO - 2015-11-02 15:26:59,336 DEBUG : BROWSER_OUTPUT: |2;Encrypt;325.626831650928 15:26:59 INFO - 2015-11-02 15:26:59,337 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5747.126436781609 15:26:59 INFO - 2015-11-02 15:26:59,337 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2059.670781893004 15:26:59 INFO - 2015-11-02 15:26:59,337 DEBUG : BROWSER_OUTPUT: |5;Earley;920.8103130755064 15:26:59 INFO - 2015-11-02 15:26:59,337 DEBUG : BROWSER_OUTPUT: |6;Boyer;12156.626506024097 15:26:59 INFO - 2015-11-02 15:26:59,337 DEBUG : BROWSER_OUTPUT: |7;RegExp;28742.85714285714 15:26:59 INFO - 2015-11-02 15:26:59,337 DEBUG : BROWSER_OUTPUT: |8;Splay;705.2186177715091 15:26:59 INFO - 2015-11-02 15:26:59,337 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;5797.687861271676 15:26:59 INFO - 2015-11-02 15:26:59,337 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:26:59 INFO - 2015-11-02 15:26:59,338 DEBUG : BROWSER_OUTPUT: __startTimestamp1446506819329__endTimestamp 15:26:59 INFO - 2015-11-02 15:26:59,338 DEBUG : BROWSER_OUTPUT: 15:26:59 INFO - 2015-11-02 15:26:59,338 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:26:59 INFO - 2015-11-02 15:26:59,338 DEBUG : BROWSER_OUTPUT: Number of tests: 10 15:26:59 INFO - 2015-11-02 15:26:59,338 DEBUG : BROWSER_OUTPUT: 15:26:59 INFO - 2015-11-02 15:26:59,338 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.83 Median:168.83 stddev:0.00 (0.0%) 15:26:59 INFO - 2015-11-02 15:26:59,338 DEBUG : BROWSER_OUTPUT: Values: 168.8 15:26:59 INFO - 2015-11-02 15:26:59,338 DEBUG : BROWSER_OUTPUT: 15:26:59 INFO - 2015-11-02 15:26:59,339 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.28 Median:191.28 stddev:0.00 (0.0%) 15:26:59 INFO - 2015-11-02 15:26:59,339 DEBUG : BROWSER_OUTPUT: Values: 191.3 15:26:59 INFO - 2015-11-02 15:26:59,339 DEBUG : BROWSER_OUTPUT: 15:26:59 INFO - 2015-11-02 15:26:59,339 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:325.63 Median:325.63 stddev:0.00 (0.0%) 15:26:59 INFO - 2015-11-02 15:26:59,339 DEBUG : BROWSER_OUTPUT: Values: 325.6 15:26:59 INFO - 2015-11-02 15:26:59,339 DEBUG : BROWSER_OUTPUT: 15:26:59 INFO - 2015-11-02 15:26:59,339 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5747.13 Median:5747.13 stddev:0.00 (0.0%) 15:26:59 INFO - 2015-11-02 15:26:59,339 DEBUG : BROWSER_OUTPUT: Values: 5747.1 15:26:59 INFO - 2015-11-02 15:26:59,339 DEBUG : BROWSER_OUTPUT: 15:26:59 INFO - 2015-11-02 15:26:59,340 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2059.67 Median:2059.67 stddev:0.00 (0.0%) 15:26:59 INFO - 2015-11-02 15:26:59,340 DEBUG : BROWSER_OUTPUT: Values: 2059.7 15:26:59 INFO - 2015-11-02 15:26:59,340 DEBUG : BROWSER_OUTPUT: 15:26:59 INFO - 2015-11-02 15:26:59,340 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:920.81 Median:920.81 stddev:0.00 (0.0%) 15:26:59 INFO - 2015-11-02 15:26:59,340 DEBUG : BROWSER_OUTPUT: Values: 920.8 15:26:59 INFO - 2015-11-02 15:26:59,340 DEBUG : BROWSER_OUTPUT: 15:26:59 INFO - 2015-11-02 15:26:59,340 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12156.63 Median:12156.63 stddev:0.00 (0.0%) 15:26:59 INFO - 2015-11-02 15:26:59,340 DEBUG : BROWSER_OUTPUT: Values: 12156.6 15:26:59 INFO - 2015-11-02 15:26:59,340 DEBUG : BROWSER_OUTPUT: 15:26:59 INFO - 2015-11-02 15:26:59,341 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:28742.86 Median:28742.86 stddev:0.00 (0.0%) 15:26:59 INFO - 2015-11-02 15:26:59,341 DEBUG : BROWSER_OUTPUT: Values: 28742.9 15:26:59 INFO - 2015-11-02 15:26:59,341 DEBUG : BROWSER_OUTPUT: 15:26:59 INFO - 2015-11-02 15:26:59,341 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:705.22 Median:705.22 stddev:0.00 (0.0%) 15:26:59 INFO - 2015-11-02 15:26:59,341 DEBUG : BROWSER_OUTPUT: Values: 705.2 15:26:59 INFO - 2015-11-02 15:26:59,341 DEBUG : BROWSER_OUTPUT: 15:26:59 INFO - 2015-11-02 15:26:59,341 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:5797.69 Median:5797.69 stddev:0.00 (0.0%) 15:26:59 INFO - 2015-11-02 15:26:59,341 DEBUG : BROWSER_OUTPUT: Values: 5797.7 15:26:59 INFO - 2015-11-02 15:26:59,341 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:26:59 INFO - 2015-11-02 15:26:59,341 DEBUG : BROWSER_OUTPUT: 15:27:00 INFO - 2015-11-02 15:27:00,002 INFO : Browser exited with error code: 0 15:27:00 INFO - 2015-11-02 15:27:00,021 INFO : Completed test v8_7 (00:00:37) 15:27:00 INFO - 2015-11-02 15:27:00,408 INFO : Completed test suite (00:20:08) 15:27:00 INFO - 2015-11-02 15:27:00,408 DEBUG : Working with test: dromaeo_css 15:27:00 INFO - 2015-11-02 15:27:00,408 DEBUG : Generating results file: dromaeo_css 15:27:00 INFO - 2015-11-02 15:27:00,409 DEBUG : Working with test: kraken 15:27:00 INFO - 2015-11-02 15:27:00,409 DEBUG : Generating results file: kraken 15:27:00 INFO - 2015-11-02 15:27:00,410 INFO : javascript benchmark 15:27:00 INFO - 2015-11-02 15:27:00,410 DEBUG : Working with test: v8_7 15:27:00 INFO - 2015-11-02 15:27:00,410 DEBUG : Generating results file: v8_7 15:27:00 INFO - 2015-11-02 15:27:00,410 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:27:00 INFO - 2015-11-02 15:27:00,460 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,55]] 15:27:00 INFO - 2015-11-02 15:27:00,460 DEBUG : process_Request line: dromaeo_css 6691.51 graph.html#tests=[[72,64,55]] 15:27:00 INFO - 2015-11-02 15:27:00,460 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:27:00 INFO - 2015-11-02 15:27:00,489 DEBUG : process_Request line: kraken 1482.60 graph.html#tests=[[232,64,55]] 15:27:00 INFO - 2015-11-02 15:27:00,489 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:27:00 INFO - 2015-11-02 15:27:00,525 DEBUG : process_Request line: v8_7 18117.30 graph.html#tests=[[230,64,55]] 15:27:00 INFO - 2015-11-02 15:27:00,526 INFO : javascript benchmark 15:27:00 INFO - 2015-11-02 15:27:00,528 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [341.17776159455707, 342.83543898928514, 343.17466493084123, 343.43676370751973, 346.34886413542534, 14638.0, 15033.774493382582, 17299.0, 17543.38598149065, 18429.63140737186, 14716.558503244893, 16052.75920861188, 17891.73162402565, 18294.451166464994, 18318.633627327446, 4846.9094453747975, 5307.230451584518, 5420.4850539198715, 5435.239066530688, 5439.048166570834, 5257.553107985826, 5392.676439413628, 5394.703291318976, 5400.675959442427, 5408.2698835657075, 5242.056429842627, 5341.626086173969, 5342.118550439173, 5350.892982140354, 5356.866078348034, 5391.595630327722, 5421.241026256327, 5429.049916264638, 5430.348358197002, 5434.864128396782, 4744.620430365597, 4760.0, 4761.523847615245, 4764.785584648699, 4766.142094423002, 12659.873401266053, 12821.423035963404, 13044.608661740163, 13050.0, 13681.657958551115, 1899.4681489183051, 1930.536671198916, 1951.365806113019, 1986.1558837494008, 1990.3929301563016, 9221.123993220634, 9277.396969197049, 9313.254939604816, 9646.228301735844, 9663.758406039835, 1465.124849354087, 1514.174774747765, 1551.2088834694275, 1555.3623014564087, 1612.6049117966056, 47835.76082119602, 50242.7487862562, 54968.45031549713, 57866.71066644682, 60064.0, 6378.266499352541, 6495.415412612888, 6550.475961923034, 6610.140681711347, 6629.370209830058, 7543.924560754432, 7548.886766698504, 7555.546667199876, 7558.508696934681, 7567.394608431312, 5527.088030475007, 5529.806456773994, 5538.16927460876, 5574.16387541872, 5580.38615752275, 5924.822255332347, 5927.792527261525, 5947.0, 5977.043673012297, 5992.31088424828, 2931.4430258250864, 2953.867075981586, 2963.555466679972, 2979.6424429068215, 2982.7166419190576, 1045.7751583409604, 1046.2257929132388, 1051.2536099369534, 1067.5836423794726, 1095.7589330347312, 443.17348145708024, 443.59411138807627, 451.44021413447746, 453.4128303846461, 453.74816976578313, 11677.31421772997, 11951.163418560618, 12007.819882701766, 12052.517899284107, 12233.816492752616, 468.6906641616517, 473.8175802316133, 480.80046780586366, 485.06866815713914, 488.05074130815933, 6346.428821406095, 6482.902756458657, 6491.578047426902, 6567.277599464055, 6576.177977752781, 545318.0, 549928.0, 556974.0, 608377.0, 621119.0, 69280.65359673169, 72956.63521682358, 73354.63322683352, 73819.26180738123, 74480.0, 480.1333592864843, 483.76779146010114, 491.7418355363463, 493.767929073335, 503.19740014676535, 10644.787104258026, 10701.197410194422, 10852.945735271272, 10915.78168436611, 10948.890511095105, 32361.35277294488, 32984.0, 33073.33853322968, 33099.33801323912, 34840.47739283862, 37460.43809342916, 38856.6114338853, 42989.78505107579, 44011.33982990194, 44224.55775442333, 6052.334243233153, 6086.2087928569, 6156.384361563808, 6170.413810687977, 6186.319504854552, 11291.616226530004, 11387.089032877515, 11501.562304711912, 11726.648200553997, 11735.76528469443, 10017.799644007226, 10125.746856328356, 10224.335418197794, 10241.078302952472, 10248.743781405525, 9756.317057805885, 9768.902310976799, 9850.064243896819, 9873.555689993824, 10100.797984040131, 9971.900280997388, 10239.590416383558, 10269.281150319406, 10272.845907311246, 10365.844512332473, 6017.669028203491, 6107.755689772359, 6110.572259941761, 6113.51091912637, 6115.0, 9756.365836220622, 9766.853497197406, 10044.246681498771, 10205.59177632916, 10208.183345332503], "dojo.html": [3194.6965038321355, 3256.9674303256975, 3282.0974232086164, 3294.5552350432686, 3320.020593924792, 5263.473652634734, 5403.2705584746045, 5450.264214331064, 5476.315460567429, 5482.862928426786, 5412.864678383043, 5418.2685337479425, 5438.483344082306, 5481.177823326503, 5592.804251851186, 4996.225585034307, 5030.06943715412, 5049.4698056704065, 5101.00530396571, 5101.642884998052, 5047.0, 5075.238714192882, 5109.412417571971, 5121.487851214886, 5122.6926384416865, 4820.060088282787, 4846.491118432549, 4992.051510213048, 5063.645544811865, 5085.160948443502, 5021.623378246646, 5063.367079115111, 5073.670211436245, 5091.389033316026, 5116.539511443951, 5022.221555658843, 5036.043151801146, 5049.368828896388, 5053.570446512051, 5055.0, 5216.217567364888, 5323.1749078892835, 5328.760205790749, 5336.813211537617, 5482.0, 5815.069588865804, 5818.7672493100645, 5819.621724587888, 5826.533877289807, 5834.708264586796, 5914.674692891889, 5924.407559244084, 5927.9703601481715, 5933.139694744238, 5951.166836642873, 5339.733013349317, 5392.299001129828, 5447.046766815792, 5455.208994695826, 5489.094299440628, 5924.348321684612, 5975.43233392827, 5981.3719559445635, 5998.910016349758, 6005.549583781234, 5697.487226149667, 5701.885962280731, 5716.399778023248, 5721.742521586539, 5735.311762588516, 5652.547796176296, 5653.971730141405, 5782.0, 5791.971040144772, 5798.594098413155, 5700.657960522382, 5701.71491425427, 5721.227634269404, 5733.598648094677, 5854.121881717691, 5727.570432217601, 5739.196512488255, 5740.54075673945, 5745.482906538348, 5746.9712651436475, 4410.470743510799, 4497.707649002804, 4564.132814765184, 4566.178087944202, 4569.588737013618, 4116.794160291974, 4149.294619914622, 4151.294279972412, 4173.269677806372, 4189.2668782962855, 5344.893102138013, 5376.327959005124, 5384.811531596375, 5392.514673679309, 5424.83725488236, 5717.628354156966, 5734.827955161351, 5807.361190269067, 5814.360420353758, 5819.359870414251, 5453.045716999509, 5460.781568737206, 5464.808731694372, 5464.972675136679, 5489.945100549024, 5178.300929374486, 5185.714785686823, 5195.844124676266, 5211.895762084737, 5246.396664383568, 5677.290338707661, 5775.740091695968, 5780.479756821822, 5860.120981852756, 5943.55423343251, 5823.534117270693, 5843.065109582446, 5845.386234445322, 5870.295564532284, 5886.6173698709445, 5862.7654893805475, 5869.647821130746, 5886.499647529837, 5888.823335299948, 5893.852653683521, 5683.1759394886685, 5777.133429985536, 5781.4218578141845, 5794.623349482439, 5810.564207684525, 5817.709114544171, 5852.209951656472, 5940.524758019435, 5953.315368732651, 5992.910106348321, 5786.334571524329, 5818.912716309174, 5826.359100498857, 5841.065429531254, 5852.297724273115, 5468.808591699271, 5612.635178713371, 5807.680577568274, 5825.70871456417, 5831.35855055952, 5400.62195646301, 5454.727263636723, 5469.535089517276, 5505.642133261325, 5571.637843540157, 5613.101903695389, 5731.484166424875, 5742.425757424391, 5757.971210143923, 5784.652920824764, 5353.277307563585, 5433.972830135982, 5673.517750991212, 5679.176519404746, 5679.77280908759], "mootools.html": [1201.7476329970705, 1679.1016806008784, 1794.7666803315572, 1805.3410505165618, 1835.697109976853, 7205.351518363346, 7846.843063138734, 7940.523568585889, 7940.722074727386, 7957.880631790527, 7682.693942029854, 7920.128785833568, 7944.96027519863, 7945.364370850332, 7959.243871832181, 1995.5609765851561, 2031.7968203179712, 2217.4345541886837, 2218.8335874809372, 2245.528439027806, 2252.493189032471, 2263.196565219348, 2265.920692775753, 2269.8638081715067, 2271.681964524968, 2197.7252843394576, 2235.1394713035515, 2238.2166241815316, 2239.428945618873, 2242.865428074321, 2007.1670256843393, 2047.2732180076082, 2183.9017244224046, 2237.2393386248755, 2242.024719247133, 2254.537819746948, 2281.452451411666, 2300.2524179641514, 2302.3553405046614, 2304.366299267698, 7846.764597062097, 7903.209679032108, 7911.050673919109, 7921.168277330912, 7931.444798864082, 4894.657373983822, 4975.328330675385, 4975.552200301954, 4977.328060711794, 4988.376452943382, 2878.150945471091, 2904.417092684492, 2947.513660246057, 2950.4246671898986, 2962.525995840655, 819.5084945399376, 872.4808738800403, 877.9385443018991, 892.1212605583495, 901.6078006067316, 10385.01342372481, 10388.792224155475, 10393.37639741618, 10403.635872744419, 10410.947945260377, 4364.170807546556, 4435.689501734848, 4486.75322857246, 4495.0, 4496.707713998645, 9027.909720902708, 9031.322650801216, 9034.909650903406, 9038.86441703375, 9046.909530904739, 4960.355153829979, 4971.850844474671, 4973.651844370859, 4974.104661161025, 4978.2034874419915, 4541.2733962565835, 4543.75046862109, 4545.954540454619, 4547.204239258117, 4554.88612784683, 3757.1546402059867, 3829.9617003829603, 3859.8842034739005, 3887.5140607424073, 3890.5604926177493, 1220.8290839282508, 1242.6458459339044, 1251.7371352016178, 1263.6335462715892, 1266.0757646917618, 1025.3335332034237, 1060.612876300145, 1061.654962137293, 1201.4893670190133, 1342.6978929740926, 7514.962425187949, 7532.435067369969, 7577.583232922132, 7577.659005344773, 7592.734254301073, 1055.5883205549842, 1093.4587379247323, 1166.854143232096, 1169.0881112732084, 1190.15498995714, 6022.819315420545, 6062.211912451353, 6062.333143354227, 6074.0, 6083.543734219951, 9105.408148470327, 9456.33805633599, 9461.621535138518, 9464.763380915394, 9469.10043545862, 9382.90617093834, 9408.106229908148, 9411.576479058458, 9420.34057615974, 9435.716928492157, 7061.9293807062295, 7181.964090179516, 7191.280871912872, 7191.928080719231, 7439.107307123071, 7375.852482950204, 7432.070991126109, 7472.0, 7478.70085196586, 7487.438442116754, 8269.131741167092, 8439.324854011542, 8491.065982742017, 8494.617742201739, 8498.957505212435, 8435.620397082268, 8615.138486151334, 8654.870176947477, 8657.480551166698, 8659.13408659129, 6967.0, 7059.5764254144915, 7061.71753129869, 7061.788146355618, 7066.516031633415, 7524.209957954555, 7534.35957943559, 7606.923930760621, 7609.847803044019, 7613.238676132342, 7097.9290207097265, 7137.1435427749, 7137.2149063604, 7172.211056783854, 7204.9279507204255, 6325.683715814283, 6561.835954101186, 6899.0, 6928.653567321715, 7017.333353331425, 7152.892706609509, 7197.856042879218, 7211.495195336276, 7212.3148300911325, 7239.493235473677, 6440.25937017249, 6509.056186852785, 6515.185601799775, 6524.217093948567, 6543.574667646588, 6571.737130514726, 6596.736130554916, 6599.6040237583975, 6609.669516524058, 6611.966940165268], "ext.html": [560.2184951991969, 562.1455387810528, 573.3062993777529, 581.9563532735043, 586.3960121075291, 31476.055718328458, 32055.358892822158, 38928.22143557127, 40027.0, 40034.0, 42679.786601067026, 43127.78436107823, 43203.78398108013, 43211.35182972258, 43245.56754432455, 8252.133525979776, 9261.907380926188, 9490.952545237264, 9497.335186536946, 9512.66705665302, 8402.453840500348, 11261.324320540753, 11393.259438136494, 11487.081033517341, 11497.0, 11234.606788762396, 11322.886771132265, 11359.034482069033, 11361.715957101056, 11367.09063274936, 8460.8730869037, 8654.567271636455, 11087.168462365315, 11223.270487418291, 11279.210455268134, 10955.671329860117, 11108.333499990027, 11120.55517779296, 11150.721231969266, 11163.0, 39781.40327895055, 40259.7987010066, 40270.0, 40298.79850600757, 40331.7983410084, 3160.7629427792776, 3241.951370729441, 3252.3332716793, 3404.3872103021445, 3467.6705712957228, 27599.862000689867, 28240.85879570589, 28364.0, 28381.0, 28479.57280640792, 2343.8593684378993, 2369.5142495788323, 2369.964450533226, 2392.8564286142714, 2469.333280014386, 292217.0, 293664.0, 294743.0, 295294.0, 296337.0, 49848.50151498439, 51438.74280628573, 59909.0, 60413.395866041654, 63932.0, 60419.39580604138, 60533.69733151394, 60757.69621151866, 60908.0, 60909.0, 16755.413560525565, 16931.576710582332, 16933.153342332833, 16934.49196524106, 16958.321667133423, 12864.356782160854, 12933.965282777355, 12947.223166610034, 12955.740885182244, 12959.546415875588, 19140.0, 19171.0, 19189.0, 19206.711899321523, 19310.420687379403, 7971.0, 8226.753197404087, 8234.505929644241, 8250.793730156794, 8279.213474719892, 965.1072757699101, 1030.4744580264119, 1039.0025575447503, 1061.8141825180562, 1168.281506873284, 28876.625778523994, 28922.566161507595, 29247.268818279714, 29404.11787646374, 29435.558466623017, 1005.626365802773, 1045.8640376750973, 1136.6817291158488, 1171.3410558033218, 1277.5017743080207, 15182.240887955559, 15233.923830380778, 15426.768598471032, 15448.150351730537, 15737.763933541006, 340679.0, 348081.0, 348427.0, 350152.0, 350296.0, 56293.71853140708, 56498.15252771212, 56505.0, 56572.71713641405, 56602.71698641563, 1398.4056775870417, 1400.9439622414989, 1410.4710733474947, 1412.3573773933042, 1414.8090007849014, 28877.71122288834, 28952.710472895844, 29038.274043148245, 29439.411211775216, 29650.851745741133, 43243.35134972915, 44055.0, 46984.53015469802, 47374.999999998625, 47430.52569474261, 327234.0, 330554.0, 333276.0, 334181.30365437095, 334627.0, 29606.851965740032, 29934.0, 29955.101346959626, 30001.549976750804, 30025.5496167562, 38042.0, 41310.79344603378, 41401.37897931594, 41425.37861932134, 41648.58351416447, 33880.83059584686, 35120.47319290264, 35406.46890296699, 35502.0, 37616.81191594025, 34899.47650785291, 35154.64845351616, 35814.28371432609, 35817.283654327286, 35879.10302242465, 34893.47659785156, 35381.29237415186, 35495.290094198484, 35722.64277357193, 36195.45706814347, 29630.407391852474, 31352.21619459532, 31548.36903261876, 31588.36823263568, 31605.20986975344, 24197.395065122808, 24312.27063188107, 24331.0, 24632.261032169063, 24708.505829883663], "prototype.html": [319.7090647510765, 331.65507871813315, 332.5510560742997, 333.7063384221884, 337.7450025230952, 6134.693265336727, 6217.813465596028, 6236.968815155924, 6239.500839932806, 6289.371062893714, 6090.451859332659, 6128.448439640431, 6174.382561743823, 6188.133661287412, 6206.906896396557, 4714.952850471503, 4722.220833562458, 4742.407199100121, 4746.928796068062, 4750.358701575295, 4579.519150489201, 4648.86053418398, 4663.8367657132, 4739.194336962724, 4757.976210118962, 4675.719456832601, 4682.157211701892, 4690.742009189493, 4707.576318131368, 4710.293455981613, 4673.766311684436, 4693.249080147177, 4700.976495117519, 4714.504976977402, 4725.929111063337, 4072.7149099563044, 4079.469668943048, 4079.9184016319805, 4080.2859499587453, 4087.264292427362, 5785.4214578541805, 6004.759809607611, 6047.455728984369, 6062.3634518375375, 6074.726637301332, 5397.433269506684, 5410.1614249790955, 5411.053065713484, 5416.160495123262, 5429.4299098594865, 6256.87486250277, 6505.60966342021, 6522.282548919662, 6543.869122617569, 6545.280019197884, 4384.342348647697, 4395.318725597537, 4456.732596044215, 4463.553644635511, 4470.351798989161, 6660.200775906922, 6739.393454589062, 6763.323667633295, 6769.695363708645, 6776.119104516381, 4507.57178068083, 4530.592246697747, 4538.591526762607, 4549.909001819945, 4554.4990051094355, 4480.7535585542455, 4576.06190730906, 4595.655325850575, 4661.463931647904, 4693.178693728584, 5387.568994480433, 5388.380336261302, 5397.487238712316, 5405.486478784509, 5413.756380962866, 6515.804525864231, 6534.346565343428, 6547.9672601636685, 6548.0, 6556.541042127101, 1673.564873132994, 1697.73685078813, 1699.422196453187, 1699.7705309783269, 1701.7617533545313, 1102.6542249354911, 1110.4114819145866, 1111.3220935229504, 1112.7551938573502, 1121.8485504456958, 6150.108234306001, 6151.784687535915, 6160.260768707783, 6167.0, 6167.537434692416, 6787.524873258923, 6793.082933803972, 6797.456203503708, 6802.4217941474535, 6814.420774234147, 6009.489193418521, 6163.660998645118, 6176.752929882754, 6177.135201071854, 6195.628262304276, 3714.2757162353623, 3742.7754334739457, 3756.3238617048646, 3757.0, 3763.9811800941366, 6833.111695479556, 6844.247132815386, 6844.726210951506, 6851.554648947803, 6858.794236172923, 6808.285130061371, 6936.34104760047, 6938.063361446241, 6960.095187625576, 6994.195667498303, 6804.727810887608, 6807.081044059088, 6809.012693159464, 6813.216480104752, 6837.794866154023, 6575.50683698715, 6618.702158402787, 6650.800475985729, 6753.088333074972, 6762.053312536151, 6589.308122647245, 6612.603243805387, 6615.735370585316, 6630.336966303331, 6637.070810086495, 6803.489738269748, 6807.455403567604, 6810.557313774589, 6814.011968264673, 6823.727050917908, 4393.055493069006, 4444.688871778944, 4483.260262056854, 4484.39460672805, 4491.573300536444, 6697.732090716317, 6711.63086030273, 6722.058911752456, 6724.831879203059, 6730.966345168439, 6480.481561475165, 6505.577137486048, 6512.120863683342, 6524.739010439529, 6540.084388185753, 6494.383033611799, 6501.902471462838, 6526.641034743135, 6582.0, 6616.536842420985, 6402.231732192166, 6443.871122577616, 6447.968325067966, 6455.741770329134, 6461.0, 6565.277819439953, 6566.704498297492, 6576.112224849584, 6578.901316480353, 6581.6709164542535, 6321.241451025906, 6392.872142557216, 6398.360163983564, 6404.423601875854, 6429.517786165963], "yui.html": [683.6718375179913, 692.2661978302999, 738.6306846576712, 784.3725019984013, 787.9093904201015, 13745.999999999987, 14072.155670659742, 14097.295135243248, 14126.22305773182, 14141.15153090814, 12069.577564785235, 12833.260247244492, 12986.54547090852, 13137.27744974026, 13158.407871645775, 910.6311943662811, 929.6420877961966, 930.3766476460754, 930.6044930904372, 930.7347405989294, 915.5010519267015, 922.0687106022932, 923.4274749655223, 923.8106188231396, 925.8981512033671, 965.0976337124775, 975.639013564982, 976.3653625143643, 976.3751199232497, 976.716752141878, 971.1793534463367, 971.5385192033763, 972.027972027972, 972.2465089555616, 972.5623469438781, 724.807925899637, 724.8369116948697, 724.9021382113452, 725.234877204549, 725.8004048886546, 10933.125349971982, 10974.615888443946, 10979.945100274528, 10996.06533444658, 11006.229563930528, 10217.489125543767, 10253.179745620333, 10308.175345972304, 10487.0, 10821.567137314498, 8769.386142969995, 8878.556072196365, 8931.37480376374, 8983.28133749305, 9160.038195989458, 3326.76712630116, 3335.1328654549748, 3372.561566996275, 3383.171123074838, 3481.477778333245, 47368.70845557748, 47682.5231747685, 47878.0, 47889.52110478885, 48220.51779482196, 6295.0, 7783.922160778433, 7938.56337901421, 7954.642041108048, 8016.438849280495, 11944.88055119455, 12063.517459301705, 12075.09436792244, 12089.093318001009, 12089.274643521418, 5935.703214839241, 6045.33501314855, 6093.055576385667, 6215.440610345, 6215.658138802319, 3649.5620525536574, 3699.611540788232, 3704.944425833615, 3708.9443658345144, 3720.925581488409, 2587.159173268695, 2616.136674897279, 2624.553825849572, 2626.566616508255, 2627.894884204649, 406.28696637401174, 413.78276404887674, 417.0636920114363, 419.9769012704331, 423.3205704843743, 482.11772456404697, 483.70977413552293, 521.2244796458872, 554.9611527193058, 567.5629765080864, 7909.3277071449575, 8528.061913189544, 8538.78653033679, 8574.742757717278, 8617.310615150773, 469.98590042298787, 476.46397802472217, 477.33888564337946, 573.2519062623234, 620.8447888027993, 3844.4041173618134, 3847.461355410245, 3868.6131386861653, 3963.742356746802, 3970.841166353371, 59966.400335996084, 61015.694921525996, 61062.0, 61218.0, 61276.0, 45168.3224751629, 45492.77253613777, 49894.75052624786, 52692.473075269525, 52709.47290527046, 42112.78943605324, 43779.0, 44011.77994110009, 45856.0, 47582.28626570604, 6895.6552172392185, 8234.176582341717, 8392.83214335722, 8442.873356899529, 8450.535220562928, 35744.10639734028, 35979.82010089933, 36429.45355819612, 36455.635443645224, 36638.63361366352, 45824.312635311166, 45933.77033114813, 46067.078658427316, 46514.534854652375, 47343.76328118475, 7212.386947109345, 7321.560706357635, 7362.116546014512, 7371.926280737124, 7416.110066792019, 10839.67480975572, 11148.77175817528, 11187.944060279646, 11256.831147532957, 11485.253458525169, 10445.843312350169, 10645.254832161674, 10857.619983300547, 10923.617673381394, 10962.451877406258, 10086.949565252127, 10455.84316235242, 10564.313319634199, 10601.946990265, 10683.679489615324, 10165.237607179342, 10735.194860385658, 10757.677269681923, 10962.397068161328, 11319.0, 8961.731148065568, 9059.184673379428, 9088.0, 9205.401648893068, 9978.151857091938, 8215.301699355621, 8614.353923455641, 8658.653653854028, 8739.43193692408, 9425.528723563932]}, "summary": {"suite": 6691.5104098134525, "subtests": {"jquery.html": {"filtered": 6791.797067615976, "value": 6791.797067615976}, "dojo.html": {"filtered": 5384.991270122737, "value": 5384.991270122737}, "mootools.html": {"filtered": 4525.596996444374, "value": 4525.596996444374}, "ext.html": {"filtered": 18947.86800892132, "value": 18947.86800892132}, "prototype.html": {"filtered": 4902.55133910833, "value": 4902.55133910833}, "yui.html": {"filtered": 5838.2116690278035, "value": 5838.2116690278035}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0001"}, "testrun": {"date": 1446505611, "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": "20151102141306", "branch": "Fx-Team", "revision": "901a0736dd16ba366d2de0ec08cab975429fa4b2"}}, {"talos_counters": {}, "results": {"audio-dft": [162.0, 160.0, 161.0, 162.0, 163.0, 163.0, 162.0, 163.0, 163.0, 160.0], "ai-astar": [105.0, 104.0, 106.0, 108.0, 108.0, 107.0, 114.0, 108.0, 107.0, 108.0], "imaging-gaussian-blur": [120.0, 120.0, 120.0, 114.0, 115.0, 115.0, 114.0, 120.0, 120.0, 120.0], "audio-beat-detection": [157.0, 129.0, 147.0, 163.0, 126.0, 149.0, 147.0, 126.0, 164.0, 125.0], "json-stringify-tinderbox": [65.0, 66.0, 66.0, 67.0, 68.0, 67.0, 66.0, 66.0, 67.0, 67.0], "stanford-crypto-pbkdf2": [149.0, 147.0, 147.0, 137.0, 150.0, 146.0, 147.0, 148.0, 145.0, 136.0], "json-parse-financial": [58.0, 56.0, 58.0, 57.0, 56.0, 57.0, 57.0, 66.0, 56.0, 55.0], "stanford-crypto-sha256-iterative": [69.0, 69.0, 68.0, 69.0, 71.0, 69.0, 71.0, 70.0, 70.0, 70.0], "audio-fft": [77.0, 81.0, 87.0, 84.0, 68.0, 70.0, 69.0, 77.0, 82.0, 66.0], "imaging-darkroom": [125.0, 125.0, 125.0, 125.0, 124.0, 125.0, 125.0, 124.0, 125.0, 125.0], "stanford-crypto-ccm": [129.0, 121.0, 130.0, 120.0, 124.0, 120.0, 122.0, 123.0, 119.0, 121.0], "audio-oscillator": [100.0, 97.0, 133.0, 88.0, 89.0, 92.0, 125.0, 87.0, 89.0, 130.0], "stanford-crypto-aes": [85.0, 86.0, 85.0, 85.0, 85.0, 85.0, 85.0, 86.0, 87.0, 88.0], "imaging-desaturate": [101.0, 101.0, 101.0, 100.0, 101.0, 101.0, 100.0, 100.0, 100.0, 102.0]}, "summary": {"suite": 1482.6000000000001, "subtests": {"audio-fft": {"filtered": 76.1, "value": 76.1}, "stanford-crypto-pbkdf2": {"filtered": 145.2, "value": 145.2}, "audio-beat-detection": {"filtered": 143.3, "value": 143.3}, "stanford-crypto-ccm": {"filtered": 122.9, "value": 122.9}, "imaging-darkroom": {"filtered": 124.8, "value": 124.8}, "json-parse-financial": {"filtered": 57.6, "value": 57.6}, "audio-oscillator": {"filtered": 103.0, "value": 103.0}, "ai-astar": {"filtered": 107.5, "value": 107.5}, "audio-dft": {"filtered": 161.9, "value": 161.9}, "stanford-crypto-sha256-iterative": {"filtered": 69.6, "value": 69.6}, "json-stringify-tinderbox": {"filtered": 66.5, "value": 66.5}, "imaging-gaussian-blur": {"filtered": 117.8, "value": 117.8}, "stanford-crypto-aes": {"filtered": 85.7, "value": 85.7}, "imaging-desaturate": {"filtered": 100.7, "value": 100.7}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0001"}, "testrun": {"date": 1446505611, "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": "20151102141306", "branch": "Fx-Team", "revision": "901a0736dd16ba366d2de0ec08cab975429fa4b2"}}, {"talos_counters": {}, "results": {"DeltaBlue": [191.27773527161438], "Encrypt": [325.626831650928], "NavierStokes": [5797.687861271676], "Decrypt": [5747.126436781609], "Splay": [705.2186177715091], "Richards": [168.83336147222693], "RegExp": [28742.85714285714], "Earley": [920.8103130755064], "Boyer": [12156.626506024097], "RayTrace": [2059.670781893004]}, "summary": {"suite": 18117.300938188575, "subtests": {"DeltaBlue": {"filtered": 345.66490400000004, "value": 345.66490400000004}, "Encrypt": {"filtered": 817.4418510000004, "value": 817.4418510000004}, "NavierStokes": {"filtered": 255.96410767696923, "value": 255.96410767696923}, "Decrypt": {"filtered": 46.31549399999997, "value": 46.31549399999997}, "Splay": {"filtered": 115.55423800000003, "value": 115.55423800000003}, "RegExp": {"filtered": 31.69430914512922, "value": 31.69430914512922}, "Richards": {"filtered": 209.09374599999995, "value": 209.09374599999995}, "Earley": {"filtered": 723.7788180000001, "value": 723.7788180000001}, "Boyer": {"filtered": 54.82302180376615, "value": 54.82302180376615}, "RayTrace": {"filtered": 359.27537862137854, "value": 359.27537862137854}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0001"}, "testrun": {"date": 1446505611, "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": "20151102141306", "branch": "Fx-Team", "revision": "901a0736dd16ba366d2de0ec08cab975429fa4b2"}}] 15:27:00 INFO - RETURN: dromaeo_css: 6691.51 15:27:00 INFO - RETURN: kraken: 1482.60 15:27:00 INFO - RETURN: v8_7: 18117.30 15:27:00 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,55]]", "result": "18117.30"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,55]]", "result": "1482.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,55]]", "result": "6691.51"}}} 15:27:00 INFO - Return code: 0 15:27:00 INFO - # TBPL SUCCESS # 15:27:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:27:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:27:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:27:00 INFO - 2015-11-02 15:27:00.654 screenresolution[1653:9809] starting screenresolution argv=screenresolution get 15:27:00 INFO - 2015-11-02 15:27:00.657 screenresolution[1653:9809] Display 0: 1600x1200x32@60 15:27:00 INFO - 2015-11-02 15:27:00.664 screenresolution[1654:9812] starting screenresolution argv=screenresolution list 15:27:00 INFO - Available Modes on Display 0 15:27:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:27:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:27:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:27:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:27:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:27:00 INFO - Intel HD Graphics 3000: 15:27:00 INFO - Chipset Model: Intel HD Graphics 3000 15:27:00 INFO - Type: GPU 15:27:00 INFO - Bus: Built-In 15:27:00 INFO - VRAM (Total): 512 MB 15:27:00 INFO - VRAM (Dynamic, Max): 10 15:27:00 INFO - Vendor: Intel (0x8086) 15:27:00 INFO - Device ID: 0x0116 15:27:00 INFO - Revision ID: 0x0009 15:27:00 INFO - Displays: 15:27:00 INFO - Display: 15:27:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:27:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:27:00 INFO - Display Serial Number: 1600x1200 60 15:27:00 INFO - Main Display: Yes 15:27:00 INFO - Mirror: Off 15:27:00 INFO - Online: Yes 15:27:00 INFO - Rotation: Supported 15:27:00 INFO - Return code: 0 15:27:00 INFO - Running post-action listener: _resource_record_post_action 15:27:00 INFO - Running post-run listener: _resource_record_post_run 15:27:01 INFO - Total resource usage - Wall time: 1248s; CPU: 30.0%; Read bytes: 37504000; Write bytes: 688059392; Read time: 3996; Write time: 15964 15:27:01 INFO - install - Wall time: 38s; CPU: 30.0%; Read bytes: 339476992; Write bytes: 337657856; Read time: 33353; Write time: 4504 15:27:02 INFO - run-tests - Wall time: 1210s; CPU: 30.0%; Read bytes: 35480576; Write bytes: 339203072; Read time: 3236; Write time: 10864 15:27:02 INFO - Running post-run listener: _upload_blobber_files 15:27:02 INFO - Blob upload gear active. 15:27:02 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 15:27:02 INFO - Copying logs to upload dir... 15:27:02 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1308.593951 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 48 secs) (at 2015-11-02 15:27:02.068802) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-02 15:27:02.072162) ========= 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.emPCSi6okE/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.VK2HLjgPY7/Listeners TMPDIR=/var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/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/zYPh7WkfQa2iw_mWkdvzsw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010136 build_url: 'https://queue.taskcluster.net/v1/task/zYPh7WkfQa2iw_mWkdvzsw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-02 15:27:02.098586) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 15:27:02.098945) ========= 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.emPCSi6okE/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.VK2HLjgPY7/Listeners TMPDIR=/var/folders/jf/52gp9c514rdf6vww0bh9hqq800000w/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.005218 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 15:27:02.149296) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-02 15:27:02.149672) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-02 15:27:02.150105) ========= ========= Total master_lag: 0.35 =========