builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0060 starttime: 1448311654.82 results: success (0) buildid: 20151120125133 builduid: 13d140bdac044294b4e815cf961efc82 revision: 924d421d766ad07c2e76a1a299ec3e05b7ad0b4f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 12:47:34.825348) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 12:47:34.825797) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 12:47:34.826095) ========= 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.H2RknxGrHl/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.7YEcNZOZDJ/Listeners TMPDIR=/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005412 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 12:47:34.845317) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 12:47:34.845593) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 12:47:34.860035) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:47:34.860320) ========= 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.H2RknxGrHl/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.7YEcNZOZDJ/Listeners TMPDIR=/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005258 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:47:34.908570) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 12:47:34.908895) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 12:47:34.909248) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:47:34.909514) ========= 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.H2RknxGrHl/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.7YEcNZOZDJ/Listeners TMPDIR=/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2015-11-23 12:47:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.41G=0s 2015-11-23 12:47:35 (1.41 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.181293 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:47:35.104357) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:47:35.104737) ========= 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.H2RknxGrHl/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.7YEcNZOZDJ/Listeners TMPDIR=/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.020497 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:47:35.155657) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 12:47:35.156216) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 924d421d766ad07c2e76a1a299ec3e05b7ad0b4f --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 924d421d766ad07c2e76a1a299ec3e05b7ad0b4f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.H2RknxGrHl/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.7YEcNZOZDJ/Listeners TMPDIR=/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2015-11-23 12:47:35,245 truncating revision to first 12 chars 2015-11-23 12:47:35,245 Setting DEBUG logging. 2015-11-23 12:47:35,245 attempt 1/10 2015-11-23 12:47:35,245 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/924d421d766a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 12:47:36,443 unpacking tar archive at: fx-team-924d421d766a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.438269 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 12:47:36.610417) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 12:47:36.610919) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 12:47:36.623361) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 12:47:36.623864) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 12:47:36.624433) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2015-11-23 12:47:36.624833) ========= /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.H2RknxGrHl/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.7YEcNZOZDJ/Listeners TMPDIR=/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 12:47:36 INFO - MultiFileLogger online at 20151123 12:47:36 in /builds/slave/test 12:47:36 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 12:47:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:47:36 INFO - {'append_to_log': False, 12:47:36 INFO - 'base_work_dir': '/builds/slave/test', 12:47:36 INFO - 'blob_upload_branch': 'Fx-Team', 12:47:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:47:36 INFO - 'branch': 'Fx-Team', 12:47:36 INFO - 'buildbot_json_path': 'buildprops.json', 12:47:36 INFO - 'config_files': ('talos/mac_config.py',), 12:47:36 INFO - 'default_actions': ('clobber', 12:47:36 INFO - 'read-buildbot-config', 12:47:36 INFO - 'download-and-extract', 12:47:36 INFO - 'populate-webroot', 12:47:36 INFO - 'create-virtualenv', 12:47:36 INFO - 'install', 12:47:36 INFO - 'run-tests'), 12:47:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:47:36 INFO - 'download_minidump_stackwalk': True, 12:47:36 INFO - 'download_symbols': 'ondemand', 12:47:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:47:36 INFO - 'tooltool.py': '/tools/tooltool.py', 12:47:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:47:36 INFO - '/tools/misc-python/virtualenv.py')}, 12:47:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:47:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:47:36 INFO - 'installer_path': 'installer.exe', 12:47:36 INFO - 'log_level': 'info', 12:47:36 INFO - 'log_name': 'talos', 12:47:36 INFO - 'log_to_console': True, 12:47:36 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:47:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:47:36 INFO - 'opt_config_files': (), 12:47:36 INFO - 'pip_index': False, 12:47:36 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:47:36 INFO - 'cmd': ('bash', 12:47:36 INFO - '-c', 12:47:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:47:36 INFO - 'enabled': True, 12:47:36 INFO - 'halt_on_failure': False, 12:47:36 INFO - 'name': 'check_screen_resolution'},), 12:47:36 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:47:36 INFO - 'cmd': ('bash', 12:47:36 INFO - '-c', 12:47:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:47:36 INFO - 'enabled': True, 12:47:36 INFO - 'halt_on_failure': False, 12:47:36 INFO - 'name': 'check_screen_resolution'},), 12:47:36 INFO - 'run_cmd_checks_enabled': True, 12:47:36 INFO - 'sps_profile': False, 12:47:36 INFO - 'sps_profile_interval': 0, 12:47:36 INFO - 'suite': 'dromaeojs', 12:47:36 INFO - 'system_bits': '64', 12:47:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:47:36 INFO - 'title': 't-yosemite-r7-0060', 12:47:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:47:36 INFO - 'use_talos_json': True, 12:47:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:47:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:47:36 INFO - 'work_dir': 'build'} 12:47:36 INFO - ##### 12:47:36 INFO - ##### Running clobber step. 12:47:36 INFO - ##### 12:47:36 INFO - Running pre-action listener: _resource_record_pre_action 12:47:36 INFO - Running main action method: clobber 12:47:36 INFO - rmtree: /builds/slave/test/build 12:47:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:47:37 INFO - Running post-action listener: _resource_record_post_action 12:47:37 INFO - ##### 12:47:37 INFO - ##### Running read-buildbot-config step. 12:47:37 INFO - ##### 12:47:37 INFO - Running pre-action listener: _resource_record_pre_action 12:47:37 INFO - Running main action method: read_buildbot_config 12:47:37 INFO - Using buildbot properties: 12:47:37 INFO - { 12:47:37 INFO - "properties": { 12:47:37 INFO - "buildnumber": 22, 12:47:37 INFO - "product": "firefox", 12:47:37 INFO - "script_repo_revision": "production", 12:47:37 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 12:47:37 INFO - "repository": "", 12:47:37 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 12:47:37 INFO - "buildid": "20151120125133", 12:47:37 INFO - "slavename": "t-yosemite-r7-0060", 12:47:37 INFO - "pgo_build": "False", 12:47:37 INFO - "basedir": "/builds/slave/test", 12:47:37 INFO - "project": "", 12:47:37 INFO - "platform": "yosemite_r7", 12:47:37 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 12:47:37 INFO - "slavebuilddir": "test", 12:47:37 INFO - "scheduler": "tests-fx-team-macosx64-talos", 12:47:37 INFO - "branch": "fx-team", 12:47:37 INFO - "repo_path": "integration/fx-team", 12:47:37 INFO - "stage_platform": "macosx64", 12:47:37 INFO - "builduid": "13d140bdac044294b4e815cf961efc82", 12:47:37 INFO - "revision": "924d421d766ad07c2e76a1a299ec3e05b7ad0b4f" 12:47:37 INFO - }, 12:47:37 INFO - "sourcestamp": { 12:47:37 INFO - "repository": "", 12:47:37 INFO - "hasPatch": false, 12:47:37 INFO - "project": "", 12:47:37 INFO - "branch": "fx-team-macosx64-talos", 12:47:37 INFO - "changes": [ 12:47:37 INFO - { 12:47:37 INFO - "category": null, 12:47:37 INFO - "files": [ 12:47:37 INFO - { 12:47:37 INFO - "url": null, 12:47:37 INFO - "name": "https://queue.taskcluster.net/v1/task/MdSlRE8ESpqsXU1pNGJNhw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 12:47:37 INFO - } 12:47:37 INFO - ], 12:47:37 INFO - "repository": "", 12:47:37 INFO - "rev": "924d421d766ad07c2e76a1a299ec3e05b7ad0b4f", 12:47:37 INFO - "who": "mconley@mozilla.com", 12:47:37 INFO - "when": 1448057752, 12:47:37 INFO - "number": 6690719, 12:47:37 INFO - "comments": "Bug 1209689 - Test forcing revived background tabs to restore on demand. r=felipe", 12:47:37 INFO - "project": "", 12:47:37 INFO - "at": "Fri 20 Nov 2015 14:15:52", 12:47:37 INFO - "branch": "fx-team-macosx64-talos", 12:47:37 INFO - "revlink": "", 12:47:37 INFO - "properties": [ 12:47:37 INFO - [ 12:47:37 INFO - "buildid", 12:47:37 INFO - "20151120125133", 12:47:37 INFO - "Change" 12:47:37 INFO - ], 12:47:37 INFO - [ 12:47:37 INFO - "builduid", 12:47:37 INFO - "13d140bdac044294b4e815cf961efc82", 12:47:37 INFO - "Change" 12:47:37 INFO - ], 12:47:37 INFO - [ 12:47:37 INFO - "pgo_build", 12:47:37 INFO - "False", 12:47:37 INFO - "Change" 12:47:37 INFO - ] 12:47:37 INFO - ], 12:47:37 INFO - "revision": "924d421d766ad07c2e76a1a299ec3e05b7ad0b4f" 12:47:37 INFO - } 12:47:37 INFO - ], 12:47:37 INFO - "revision": "924d421d766ad07c2e76a1a299ec3e05b7ad0b4f" 12:47:37 INFO - } 12:47:37 INFO - } 12:47:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/MdSlRE8ESpqsXU1pNGJNhw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 12:47:37 INFO - Running post-action listener: _resource_record_post_action 12:47:37 INFO - ##### 12:47:37 INFO - ##### Running download-and-extract step. 12:47:37 INFO - ##### 12:47:37 INFO - Running pre-action listener: _resource_record_pre_action 12:47:37 INFO - Running main action method: download_and_extract 12:47:37 INFO - mkdir: /builds/slave/test/build/tests 12:47:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:37 INFO - https://queue.taskcluster.net/v1/task/MdSlRE8ESpqsXU1pNGJNhw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:47:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdSlRE8ESpqsXU1pNGJNhw/artifacts/public/build/test_packages.json 12:47:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdSlRE8ESpqsXU1pNGJNhw/artifacts/public/build/test_packages.json 12:47:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdSlRE8ESpqsXU1pNGJNhw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 12:47:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdSlRE8ESpqsXU1pNGJNhw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 12:47:38 INFO - Downloaded 1149 bytes. 12:47:38 INFO - Reading from file /builds/slave/test/build/test_packages.json 12:47:38 INFO - Using the following test package requirements: 12:47:38 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 12:47:38 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:47:38 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 12:47:38 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:47:38 INFO - u'jsshell-mac.zip'], 12:47:38 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:47:38 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 12:47:38 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 12:47:38 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:47:38 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 12:47:38 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:47:38 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 12:47:38 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:47:38 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 12:47:38 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 12:47:38 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:47:38 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 12:47:38 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:47: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')]} 12:47:38 INFO - https://queue.taskcluster.net/v1/task/MdSlRE8ESpqsXU1pNGJNhw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:47:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdSlRE8ESpqsXU1pNGJNhw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:47:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdSlRE8ESpqsXU1pNGJNhw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:47:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdSlRE8ESpqsXU1pNGJNhw/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 12:47:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdSlRE8ESpqsXU1pNGJNhw/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 12:47:39 INFO - Downloaded 17526773 bytes. 12:47:39 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 12:47:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:47:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 12:47:42 INFO - Return code: 0 12:47:42 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 12:47: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')]} 12:47:42 INFO - https://queue.taskcluster.net/v1/task/MdSlRE8ESpqsXU1pNGJNhw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:47:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdSlRE8ESpqsXU1pNGJNhw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:47:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdSlRE8ESpqsXU1pNGJNhw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:47:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdSlRE8ESpqsXU1pNGJNhw/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 12:47:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdSlRE8ESpqsXU1pNGJNhw/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 12:47:43 INFO - Downloaded 17526773 bytes. 12:47:43 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 12:47:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:47:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 12:47:46 INFO - Return code: 0 12:47:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:46 INFO - https://queue.taskcluster.net/v1/task/MdSlRE8ESpqsXU1pNGJNhw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 12:47:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdSlRE8ESpqsXU1pNGJNhw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 12:47:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdSlRE8ESpqsXU1pNGJNhw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 12:47:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdSlRE8ESpqsXU1pNGJNhw/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 12:47:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdSlRE8ESpqsXU1pNGJNhw/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 12:47:47 INFO - Downloaded 11130997 bytes. 12:47:47 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 12:47:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 12:47:47 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 12:47:47 INFO - Return code: 0 12:47: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')]} 12:47:47 INFO - https://queue.taskcluster.net/v1/task/MdSlRE8ESpqsXU1pNGJNhw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 12:47:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdSlRE8ESpqsXU1pNGJNhw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 12:47:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdSlRE8ESpqsXU1pNGJNhw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 12:47:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdSlRE8ESpqsXU1pNGJNhw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 12:47:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdSlRE8ESpqsXU1pNGJNhw/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 12:47:50 INFO - Downloaded 109416335 bytes. 12:47:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MdSlRE8ESpqsXU1pNGJNhw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 12:47:50 INFO - mkdir: /builds/slave/test/properties 12:47:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:47:50 INFO - Writing to file /builds/slave/test/properties/build_url 12:47:50 INFO - Contents: 12:47:50 INFO - build_url:https://queue.taskcluster.net/v1/task/MdSlRE8ESpqsXU1pNGJNhw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 12:47:50 INFO - Running post-action listener: _resource_record_post_action 12:47:50 INFO - Running post-action listener: set_extra_try_arguments 12:47:50 INFO - ##### 12:47:50 INFO - ##### Running populate-webroot step. 12:47:50 INFO - ##### 12:47:50 INFO - Running pre-action listener: _resource_record_pre_action 12:47:50 INFO - Running main action method: populate_webroot 12:47:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:47:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:47:50 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 12:47:50 INFO - '../fennec_ids.txt'], 12:47:50 INFO - 'tests': ['tcheck2']}, 12:47:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:47:50 INFO - '--tppagecycles', 12:47:50 INFO - '7'], 12:47:50 INFO - 'tests': ['tsvgm']}}, 12:47:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:47:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:47:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:47:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:47:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:47:50 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:47:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:47:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:47:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:47:50 INFO - 'talos_options': ['--e10s'], 12:47:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:47:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:47:50 INFO - 'tests': ['damp', 'tps']}, 12:47:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:47:50 INFO - 'talos_options': ['--e10s'], 12:47:50 INFO - 'tests': ['damp', 'tps']}, 12:47:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:47:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:47:50 INFO - 'other': {'tests': ['a11yr', 12:47:50 INFO - 'ts_paint', 12:47:50 INFO - 'tpaint', 12:47:50 INFO - 'sessionrestore', 12:47:50 INFO - 'sessionrestore_no_auto_restore']}, 12:47:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:47:50 INFO - 'tests': ['a11yr', 12:47:50 INFO - 'ts_paint', 12:47:50 INFO - 'tpaint', 12:47:50 INFO - 'sessionrestore', 12:47:50 INFO - 'sessionrestore_no_auto_restore']}, 12:47:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:47:50 INFO - 'tests': ['a11yr', 12:47:50 INFO - 'ts_paint', 12:47:50 INFO - 'tpaint', 12:47:50 INFO - 'sessionrestore', 12:47:50 INFO - 'sessionrestore_no_auto_restore']}, 12:47:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:47:50 INFO - 'tests': ['a11yr', 12:47:50 INFO - 'ts_paint', 12:47:50 INFO - 'tpaint', 12:47:50 INFO - 'sessionrestore', 12:47:50 INFO - 'sessionrestore_no_auto_restore']}, 12:47:50 INFO - 'other_l64': {'tests': ['a11yr', 12:47:50 INFO - 'ts_paint', 12:47:50 INFO - 'tpaint', 12:47:50 INFO - 'sessionrestore', 12:47:50 INFO - 'sessionrestore_no_auto_restore']}, 12:47:50 INFO - 'other_nol64': {'tests': ['a11yr', 12:47:50 INFO - 'ts_paint', 12:47:50 INFO - 'tpaint', 12:47:50 INFO - 'sessionrestore', 12:47:50 INFO - 'sessionrestore_no_auto_restore']}, 12:47:50 INFO - 'svgr': {'tests': ['tsvgx', 12:47:50 INFO - 'tsvgr_opacity', 12:47:50 INFO - 'tart', 12:47:50 INFO - 'tscrollx', 12:47:50 INFO - 'cart']}, 12:47:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:47:50 INFO - 'tests': ['tsvgx', 12:47:50 INFO - 'tsvgr_opacity', 12:47:50 INFO - 'tart', 12:47:50 INFO - 'tscrollx', 12:47:50 INFO - 'cart']}, 12:47:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:47:50 INFO - 'tests': ['tp5o']}, 12:47:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:47:50 INFO - 'talos_options': ['--e10s'], 12:47:50 INFO - 'tests': ['tp5o']}, 12:47:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:47:50 INFO - 'talos_options': ['--xperf_path', 12:47:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:47:50 INFO - 'tests': ['tp5n']}, 12:47:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:47:50 INFO - 'talos_options': ['--e10s', 12:47:50 INFO - '--xperf_path', 12:47:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:47:50 INFO - 'tests': ['tp5n']}}, 12:47:50 INFO - 'talos.zip': {'path': '', 12:47:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:47:50 INFO - Running post-action listener: _resource_record_post_action 12:47:50 INFO - ##### 12:47:50 INFO - ##### Running create-virtualenv step. 12:47:50 INFO - ##### 12:47:50 INFO - Running pre-action listener: _resource_record_pre_action 12:47:50 INFO - Running main action method: create_virtualenv 12:47:50 INFO - Creating virtualenv /builds/slave/test/build/venv 12:47:50 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 12:47:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:47:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:47:50 INFO - Using real prefix '/tools/python27' 12:47:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:47:51 INFO - Installing distribute.............................................................................................................................................................................................done. 12:47:54 INFO - Installing pip.................done. 12:47:54 INFO - Return code: 0 12:47:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:47:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109458490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109435228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f826a4a3e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10937c9f0>, '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 0x1090dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10936f8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H2RknxGrHl/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.7YEcNZOZDJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:47:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:47:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:47:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H2RknxGrHl/Render', 12:47:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:47:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:47:54 INFO - 'HOME': '/Users/cltbld', 12:47:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:47:54 INFO - 'LOGNAME': 'cltbld', 12:47:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:54 INFO - 'MOZ_NO_REMOTE': '1', 12:47:54 INFO - 'NO_EM_RESTART': '1', 12:47:54 INFO - 'PAGER': '/bin/cat', 12:47:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:47:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:47:54 INFO - 'PWD': '/builds/slave/test', 12:47:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:47:54 INFO - 'SHELL': '/bin/bash', 12:47:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7YEcNZOZDJ/Listeners', 12:47:54 INFO - 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/', 12:47:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:47:54 INFO - 'USER': 'cltbld', 12:47:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:47:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:47:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:54 INFO - 'XPC_FLAGS': '0x0', 12:47:54 INFO - 'XPC_SERVICE_NAME': '0', 12:47:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:47:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:54 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 12:47:54 INFO - Cleaning up... 12:47:54 INFO - Return code: 0 12:47:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:47:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109458490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109435228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f826a4a3e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10937c9f0>, '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 0x1090dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10936f8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H2RknxGrHl/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.7YEcNZOZDJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:47:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 12:47:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 12:47:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H2RknxGrHl/Render', 12:47:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:47:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:47:54 INFO - 'HOME': '/Users/cltbld', 12:47:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:47:54 INFO - 'LOGNAME': 'cltbld', 12:47:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:54 INFO - 'MOZ_NO_REMOTE': '1', 12:47:54 INFO - 'NO_EM_RESTART': '1', 12:47:54 INFO - 'PAGER': '/bin/cat', 12:47:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:47:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:47:54 INFO - 'PWD': '/builds/slave/test', 12:47:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:47:54 INFO - 'SHELL': '/bin/bash', 12:47:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7YEcNZOZDJ/Listeners', 12:47:54 INFO - 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/', 12:47:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:47:54 INFO - 'USER': 'cltbld', 12:47:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:47:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:47:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:54 INFO - 'XPC_FLAGS': '0x0', 12:47:54 INFO - 'XPC_SERVICE_NAME': '0', 12:47:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:47:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:55 INFO - Downloading/unpacking psutil>=0.7.1 12:47:55 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 12:47:55 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 12:47:55 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 12:47:55 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 12:47:55 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 12:47:55 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 12:47:57 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 12:47:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 12:47:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:47:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:47:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:47:57 INFO - Installing collected packages: psutil 12:47:57 INFO - Running setup.py install for psutil 12:47:57 INFO - building 'psutil._psutil_osx' extension 12:47:57 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 12:47:58 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 12:47:58 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 12:47:58 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 12:47:58 INFO - building 'psutil._psutil_posix' extension 12:47:58 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 12:47:58 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:47:58 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:47:58 INFO - ^ 12:47:58 INFO - 1 warning generated. 12:47:58 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 12:47:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:47:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:47:58 INFO - Successfully installed psutil 12:47:58 INFO - Cleaning up... 12:47:58 INFO - Return code: 0 12:47:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:47:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109458490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109435228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f826a4a3e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10937c9f0>, '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 0x1090dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10936f8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H2RknxGrHl/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.7YEcNZOZDJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:47:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 12:47:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 12:47:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H2RknxGrHl/Render', 12:47:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:47:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:47:58 INFO - 'HOME': '/Users/cltbld', 12:47:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:47:58 INFO - 'LOGNAME': 'cltbld', 12:47:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:58 INFO - 'MOZ_NO_REMOTE': '1', 12:47:58 INFO - 'NO_EM_RESTART': '1', 12:47:58 INFO - 'PAGER': '/bin/cat', 12:47:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:47:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:47:58 INFO - 'PWD': '/builds/slave/test', 12:47:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:47:58 INFO - 'SHELL': '/bin/bash', 12:47:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7YEcNZOZDJ/Listeners', 12:47:58 INFO - 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/', 12:47:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:47:58 INFO - 'USER': 'cltbld', 12:47:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:47:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:47:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:58 INFO - 'XPC_FLAGS': '0x0', 12:47:58 INFO - 'XPC_SERVICE_NAME': '0', 12:47:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:47:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:47:58 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 12:47:58 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 12:47:58 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 12:47:58 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 12:47:58 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 12:47:58 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 12:48:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:48:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 12:48:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:48:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:48:01 INFO - Installing collected packages: mozsystemmonitor 12:48:01 INFO - Running setup.py install for mozsystemmonitor 12:48:01 INFO - Successfully installed mozsystemmonitor 12:48:01 INFO - Cleaning up... 12:48:01 INFO - Return code: 0 12:48:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:48:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:48:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:48:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:01 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 0x109458490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109435228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f826a4a3e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10937c9f0>, '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 0x1090dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10936f8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H2RknxGrHl/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.7YEcNZOZDJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:48:01 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 12:48:01 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 12:48:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H2RknxGrHl/Render', 12:48:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:48:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:48:01 INFO - 'HOME': '/Users/cltbld', 12:48:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:48:01 INFO - 'LOGNAME': 'cltbld', 12:48:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:01 INFO - 'MOZ_NO_REMOTE': '1', 12:48:01 INFO - 'NO_EM_RESTART': '1', 12:48:01 INFO - 'PAGER': '/bin/cat', 12:48:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:48:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:01 INFO - 'PWD': '/builds/slave/test', 12:48:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:48:01 INFO - 'SHELL': '/bin/bash', 12:48:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7YEcNZOZDJ/Listeners', 12:48:01 INFO - 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/', 12:48:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:48:01 INFO - 'USER': 'cltbld', 12:48:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:48:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:48:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:01 INFO - 'XPC_FLAGS': '0x0', 12:48:01 INFO - 'XPC_SERVICE_NAME': '0', 12:48:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:48:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:01 INFO - Downloading/unpacking blobuploader==1.2.4 12:48:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:03 INFO - Downloading blobuploader-1.2.4.tar.gz 12:48:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 12:48:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:48:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:48:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 12:48:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:48:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:04 INFO - Downloading docopt-0.6.1.tar.gz 12:48:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 12:48:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:48:05 INFO - Installing collected packages: blobuploader, requests, docopt 12:48:05 INFO - Running setup.py install for blobuploader 12:48:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:48:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:48:05 INFO - Running setup.py install for requests 12:48:05 INFO - Running setup.py install for docopt 12:48:05 INFO - Successfully installed blobuploader requests docopt 12:48:05 INFO - Cleaning up... 12:48:05 INFO - Return code: 0 12:48:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:48:05 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')]} 12:48:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:05 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')]} 12:48:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:05 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 0x109458490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109435228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f826a4a3e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10937c9f0>, '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 0x1090dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10936f8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H2RknxGrHl/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.7YEcNZOZDJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:48:05 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 12:48:05 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 12:48:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H2RknxGrHl/Render', 12:48:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:48:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:48:05 INFO - 'HOME': '/Users/cltbld', 12:48:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:48:05 INFO - 'LOGNAME': 'cltbld', 12:48:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:05 INFO - 'MOZ_NO_REMOTE': '1', 12:48:05 INFO - 'NO_EM_RESTART': '1', 12:48:05 INFO - 'PAGER': '/bin/cat', 12:48:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:48:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:05 INFO - 'PWD': '/builds/slave/test', 12:48:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:48:05 INFO - 'SHELL': '/bin/bash', 12:48:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7YEcNZOZDJ/Listeners', 12:48:05 INFO - 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/', 12:48:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:48:05 INFO - 'USER': 'cltbld', 12:48:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:48:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:48:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:05 INFO - 'XPC_FLAGS': '0x0', 12:48:05 INFO - 'XPC_SERVICE_NAME': '0', 12:48:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:48:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:48:06 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-v7ldUy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:48:06 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-IQ8EZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:48:06 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-bGrq0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:48:06 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-iAWOIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:48:06 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-eD_77y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:48:06 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-Gh64GZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:48:06 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-GmkCtT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:48:06 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-ieUFwT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:48:07 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-dstI7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:48:07 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-o9kyPn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:48:07 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-NDcgki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:48:07 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-z_xW3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:48:07 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-D0bLE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:48:07 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-DqYaD3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:48:07 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-NUKK9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:48:07 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-0aJRI1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:48:07 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-ZRUfR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:48:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:48:07 INFO - Running setup.py install for manifestparser 12:48:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:48:08 INFO - Running setup.py install for mozcrash 12:48:08 INFO - Running setup.py install for mozdebug 12:48:08 INFO - Running setup.py install for mozdevice 12:48:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:48:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:48:08 INFO - Running setup.py install for mozfile 12:48:08 INFO - Running setup.py install for mozhttpd 12:48:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:48:08 INFO - Running setup.py install for mozinfo 12:48:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:48:09 INFO - Running setup.py install for mozInstall 12:48:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:48:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:48:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:48:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:48:09 INFO - Running setup.py install for mozleak 12:48:09 INFO - Running setup.py install for mozlog 12:48:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:48:09 INFO - Running setup.py install for moznetwork 12:48:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:48:09 INFO - Running setup.py install for mozprocess 12:48:09 INFO - Running setup.py install for mozprofile 12:48:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:48:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:48:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:48:09 INFO - Running setup.py install for mozrunner 12:48:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:48:10 INFO - Running setup.py install for mozscreenshot 12:48:10 INFO - Running setup.py install for moztest 12:48:10 INFO - Running setup.py install for mozversion 12:48:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:48:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:48:10 INFO - Cleaning up... 12:48:10 INFO - Return code: 0 12:48:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:48:10 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')]} 12:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:10 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')]} 12:48:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:10 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 0x109458490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109435228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f826a4a3e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10937c9f0>, '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 0x1090dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10936f8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H2RknxGrHl/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.7YEcNZOZDJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:48:10 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 12:48:10 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 12:48:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H2RknxGrHl/Render', 12:48:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:48:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:48:10 INFO - 'HOME': '/Users/cltbld', 12:48:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:48:10 INFO - 'LOGNAME': 'cltbld', 12:48:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:10 INFO - 'MOZ_NO_REMOTE': '1', 12:48:10 INFO - 'NO_EM_RESTART': '1', 12:48:10 INFO - 'PAGER': '/bin/cat', 12:48:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:48:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:10 INFO - 'PWD': '/builds/slave/test', 12:48:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:48:10 INFO - 'SHELL': '/bin/bash', 12:48:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7YEcNZOZDJ/Listeners', 12:48:10 INFO - 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/', 12:48:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:48:10 INFO - 'USER': 'cltbld', 12:48:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:48:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:48:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:10 INFO - 'XPC_FLAGS': '0x0', 12:48:10 INFO - 'XPC_SERVICE_NAME': '0', 12:48:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:48:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:48:10 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-3_uPsg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:48:10 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)) 12:48:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:48:10 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-68R0uP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:48:11 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)) 12:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:48:11 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-2ucOHz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:48:11 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)) 12:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:48:11 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-YsxhqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:48:11 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)) 12:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:48:11 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-x4uq_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:48:11 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)) 12:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:48:11 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-d2s2XP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:48:11 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)) 12:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:48:11 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-oiCNJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:48:11 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)) 12:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:48:11 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-fbEESW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:48:11 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)) 12:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:48:11 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-Tkhqf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:48:11 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)) 12:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:48:11 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-sNBC3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:48:11 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)) 12:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:48:11 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-dV3wn7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:48:12 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)) 12:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:48:12 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-V19Xwi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:48:12 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)) 12:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:48:12 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-WH8OrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:48:12 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)) 12:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:48:12 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-lofksf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:48:12 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)) 12:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:48:12 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-sseVDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:48:12 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)) 12:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:48:12 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-FTQKXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:48:12 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)) 12:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:48:12 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-fXQuoG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:48:12 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)) 12:48:12 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)) 12:48: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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:48:12 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)) 12:48:12 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)) 12:48:12 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)) 12:48:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:48:12 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 12:48:12 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 12:48:12 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 12:48:12 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 12:48:12 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 12:48:12 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 12:48:14 INFO - Downloading blessings-1.5.1.tar.gz 12:48:14 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 12:48:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:48:14 INFO - Installing collected packages: blessings 12:48:14 INFO - Running setup.py install for blessings 12:48:15 INFO - Successfully installed blessings 12:48:15 INFO - Cleaning up... 12:48:15 INFO - Return code: 0 12:48:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:48:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:48:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:48:15 INFO - Reading from file tmpfile_stdout 12:48:15 INFO - Current package versions: 12:48:15 INFO - blessings == 1.5.1 12:48:15 INFO - blobuploader == 1.2.4 12:48:15 INFO - docopt == 0.6.1 12:48:15 INFO - manifestparser == 1.1 12:48:15 INFO - mozInstall == 1.12 12:48:15 INFO - mozcrash == 0.16 12:48:15 INFO - mozdebug == 0.1 12:48:15 INFO - mozdevice == 0.47 12:48:15 INFO - mozfile == 1.2 12:48:15 INFO - mozhttpd == 0.7 12:48:15 INFO - mozinfo == 0.9 12:48:15 INFO - mozleak == 0.1 12:48:15 INFO - mozlog == 3.0 12:48:15 INFO - moznetwork == 0.27 12:48:15 INFO - mozprocess == 0.22 12:48:15 INFO - mozprofile == 0.27 12:48:15 INFO - mozrunner == 6.11 12:48:15 INFO - mozscreenshot == 0.1 12:48:15 INFO - mozsystemmonitor == 0.0 12:48:15 INFO - moztest == 0.7 12:48:15 INFO - mozversion == 1.4 12:48:15 INFO - psutil == 3.1.1 12:48:15 INFO - requests == 1.2.3 12:48:15 INFO - wsgiref == 0.1.2 12:48:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:48:15 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')]} 12:48:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:15 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')]} 12:48:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:15 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 0x109458490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109435228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f826a4a3e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10937c9f0>, '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 0x1090dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10936f8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H2RknxGrHl/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.7YEcNZOZDJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:48:15 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 12:48:15 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 12:48:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H2RknxGrHl/Render', 12:48:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:48:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:48:15 INFO - 'HOME': '/Users/cltbld', 12:48:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:48:15 INFO - 'LOGNAME': 'cltbld', 12:48:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:15 INFO - 'MOZ_NO_REMOTE': '1', 12:48:15 INFO - 'NO_EM_RESTART': '1', 12:48:15 INFO - 'PAGER': '/bin/cat', 12:48:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:48:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:15 INFO - 'PWD': '/builds/slave/test', 12:48:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:48:15 INFO - 'SHELL': '/bin/bash', 12:48:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7YEcNZOZDJ/Listeners', 12:48:15 INFO - 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/', 12:48:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:48:15 INFO - 'USER': 'cltbld', 12:48:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:48:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:48:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:15 INFO - 'XPC_FLAGS': '0x0', 12:48:15 INFO - 'XPC_SERVICE_NAME': '0', 12:48:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:48:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:48:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 12:48:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:48:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:48:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 12:48:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 12:48:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 12:48:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 12:48:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:48:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:48:15 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:48:15 INFO - Cleaning up... 12:48:15 INFO - Return code: 0 12:48:15 INFO - Running post-action listener: _resource_record_post_action 12:48:15 INFO - Running post-action listener: _start_resource_monitoring 12:48:15 INFO - Starting resource monitoring. 12:48:15 INFO - ##### 12:48:15 INFO - ##### Running install step. 12:48:15 INFO - ##### 12:48:15 INFO - Running pre-action listener: _resource_record_pre_action 12:48:15 INFO - Running main action method: install 12:48:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:48:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:48:15 INFO - Reading from file tmpfile_stdout 12:48:15 INFO - Detecting whether we're running mozinstall >=1.0... 12:48:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:48:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:48:16 INFO - Reading from file tmpfile_stdout 12:48:16 INFO - Output received: 12:48:16 INFO - Usage: mozinstall [options] installer 12:48:16 INFO - Options: 12:48:16 INFO - -h, --help show this help message and exit 12:48:16 INFO - -d DEST, --destination=DEST 12:48:16 INFO - Directory to install application into. [default: 12:48:16 INFO - "/builds/slave/test"] 12:48:16 INFO - --app=APP Application being installed. [default: firefox] 12:48:16 INFO - mkdir: /builds/slave/test/build/application 12:48:16 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'] 12:48:16 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 12:48:46 INFO - Reading from file tmpfile_stdout 12:48:46 INFO - Output received: 12:48:46 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:48:46 INFO - Running post-action listener: _resource_record_post_action 12:48:46 INFO - ##### 12:48:46 INFO - ##### Running run-tests step. 12:48:46 INFO - ##### 12:48:46 INFO - Running pre-action listener: _resource_record_pre_action 12:48:46 INFO - Running main action method: run_tests 12:48:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:48:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:48:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:48:46 INFO - 2015-11-23 12:48:46.295 screenresolution[3217:55394] starting screenresolution argv=screenresolution get 12:48:46 INFO - 2015-11-23 12:48:46.297 screenresolution[3217:55394] Display 0: 1600x1200x32@60 12:48:46 INFO - 2015-11-23 12:48:46.303 screenresolution[3218:55396] starting screenresolution argv=screenresolution list 12:48:46 INFO - Available Modes on Display 0 12:48:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:48:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:48:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:48:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:48:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:48:46 INFO - Intel Iris: 12:48:46 INFO - Chipset Model: Intel Iris 12:48:46 INFO - Type: GPU 12:48:46 INFO - Bus: Built-In 12:48:46 INFO - VRAM (Dynamic, Max): 1536 MB 12:48:46 INFO - Vendor: Intel (0x8086) 12:48:46 INFO - Device ID: 0x0a2e 12:48:46 INFO - Revision ID: 0x0009 12:48:46 INFO - Displays: 12:48:46 INFO - Display: 12:48:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:48:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:48:46 INFO - Display Serial Number: 1600x1200 60 12:48:46 INFO - Main Display: Yes 12:48:46 INFO - Mirror: Off 12:48:46 INFO - Online: Yes 12:48:46 INFO - Rotation: Supported 12:48:46 INFO - Return code: 0 12:48:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:48:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:48:46 INFO - Python 2.7.3 12:48:46 INFO - Return code: 0 12:48:46 INFO - grabbing minidump binary from tooltool 12:48:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:48:46 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 0x10937c9f0>, '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 0x1090dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10936f8c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:48:46 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 12:48:46 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 12:48:46 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:48:46 INFO - Return code: 0 12:48:46 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:48:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:48:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:48:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:48:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:48:46 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/MdSlRE8ESpqsXU1pNGJNhw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0060', '--webServer', 'localhost'] in /builds/slave/test/build 12:48:46 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/MdSlRE8ESpqsXU1pNGJNhw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0060 --webServer localhost 12:48:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H2RknxGrHl/Render', 12:48:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:48:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:48:46 INFO - 'HOME': '/Users/cltbld', 12:48:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:48:46 INFO - 'LOGNAME': 'cltbld', 12:48:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:48:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:48:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:46 INFO - 'MOZ_NO_REMOTE': '1', 12:48:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:48:46 INFO - 'NO_EM_RESTART': '1', 12:48:46 INFO - 'PAGER': '/bin/cat', 12:48:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:48:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:46 INFO - 'PWD': '/builds/slave/test', 12:48:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:48:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:48:46 INFO - 'SHELL': '/bin/bash', 12:48:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7YEcNZOZDJ/Listeners', 12:48:46 INFO - 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/', 12:48:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:48:46 INFO - 'USER': 'cltbld', 12:48:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:48:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:48:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:46 INFO - 'XPC_FLAGS': '0x0', 12:48:46 INFO - 'XPC_SERVICE_NAME': '0', 12:48:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:48:46 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/MdSlRE8ESpqsXU1pNGJNhw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0060', '--webServer', 'localhost'] with output_timeout 3600 12:48:46 INFO - mozversion INFO | application_buildid: 20151120125133 12:48:46 INFO - mozversion INFO | application_changeset: 924d421d766ad07c2e76a1a299ec3e05b7ad0b4f 12:48:46 INFO - mozversion INFO | application_display_name: Nightly 12:48:46 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:48:46 INFO - mozversion INFO | application_name: Firefox 12:48:46 INFO - mozversion INFO | application_remotingname: firefox 12:48:46 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 12:48:46 INFO - mozversion INFO | application_vendor: Mozilla 12:48:46 INFO - mozversion INFO | application_version: 45.0a1 12:48:46 INFO - mozversion INFO | platform_buildid: 20151120125133 12:48:46 INFO - mozversion INFO | platform_changeset: 924d421d766ad07c2e76a1a299ec3e05b7ad0b4f 12:48:46 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 12:48:46 INFO - mozversion INFO | platform_version: 45.0a1 12:48:46 INFO - 2015-11-23 12:48:46,842 DEBUG : using testdate: 1448311726 12:48:46 INFO - 2015-11-23 12:48:46,842 DEBUG : actual date: 1448311726 12:48:47 INFO - 2015-11-23 12:48:47,371 INFO : starting webserver on 'localhost:53187' 12:48:47 INFO - 2015-11-23 12:48:47,372 INFO : Starting test suite t-yosemite-r7-0060 12:48:47 INFO - 2015-11-23 12:48:47,372 INFO : Starting test dromaeo_css 12:48:47 INFO - 2015-11-23 12:48:47,372 DEBUG : operating with platform_type : mac_ 12:48:47 INFO - 2015-11-23 12:48:47,373 INFO : Initialising browser for dromaeo_css test... 12:48:47 INFO - 2015-11-23 12:48:47,385 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/tmphAgz2O/profile http://localhost:53187/getInfo.html 12:48:49 INFO - 2015-11-23 12:48:49,353 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:48:49 INFO - 2015-11-23 12:48:49,354 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:48:49 INFO - 2015-11-23 12:48:49,354 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 12:48:49 INFO - 2015-11-23 12:48:49,354 DEBUG : BROWSER_OUTPUT: __metrics 12:48:49 INFO - 2015-11-23 12:48:49,373 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:48:49 INFO - 2015-11-23 12:48:49,624 DEBUG : BROWSER_OUTPUT: console.error: 12:48:49 INFO - 2015-11-23 12:48:49,626 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 12:48:49 INFO - 2015-11-23 12:48:49,626 DEBUG : BROWSER_OUTPUT: Stack: 12:48:49 INFO - 2015-11-23 12:48:49,626 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 12:48:49 INFO - 2015-11-23 12:48:49,627 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 12:48:49 INFO - 2015-11-23 12:48:49,627 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 12:48:49 INFO - 2015-11-23 12:48:49,627 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 12:48:49 INFO - 2015-11-23 12:48:49,627 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 12:48:49 INFO - 2015-11-23 12:48:49,627 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 12:48:49 INFO - 2015-11-23 12:48:49,627 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 12:48:49 INFO - 2015-11-23 12:48:49,627 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 12:48:49 INFO - 2015-11-23 12:48:49,627 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 12:48:49 INFO - 2015-11-23 12:48:49,627 DEBUG : BROWSER_OUTPUT: 12:48:50 INFO - 2015-11-23 12:48:50,041 INFO : Browser initialized. 12:48:50 INFO - 2015-11-23 12:48:50,041 INFO : Running cycle 1/1 for dromaeo_css test... 12:48:50 INFO - 2015-11-23 12:48:50,041 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/tmphAgz2O/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:49:01 INFO - 2015-11-23 12:49:01,903 DEBUG : BROWSER_OUTPUT: RSS: Main: 224145408 12:49:01 INFO - 2015-11-23 12:49:01,904 DEBUG : BROWSER_OUTPUT: 12:49:59 INFO - 2015-11-23 12:49:59,320 DEBUG : BROWSER_OUTPUT: 1448311799319 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] 12:52:04 INFO - 2015-11-23 12:52:04,881 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53187/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53187/tests/dromaeo/cssquery-ext.html) 12:52:06 INFO - 2015-11-23 12:52:06,189 DEBUG : BROWSER_OUTPUT: RSS: Main: 359743488 12:52:06 INFO - 2015-11-23 12:52:06,189 DEBUG : BROWSER_OUTPUT: 12:55:08 INFO - 2015-11-23 12:55:08,935 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53187/tests/dromaeo/cssquery-ext.html (next: http://localhost:53187/tests/dromaeo/cssquery-jquery.html) 12:55:09 INFO - 2015-11-23 12:55:09,530 DEBUG : BROWSER_OUTPUT: RSS: Main: 360423424 12:55:09 INFO - 2015-11-23 12:55:09,530 DEBUG : BROWSER_OUTPUT: 12:58:11 INFO - 2015-11-23 12:58:11,695 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53187/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53187/tests/dromaeo/cssquery-mootools.html) 12:58:12 INFO - 2015-11-23 12:58:12,283 DEBUG : BROWSER_OUTPUT: RSS: Main: 348524544 12:58:12 INFO - 2015-11-23 12:58:12,283 DEBUG : BROWSER_OUTPUT: 13:01:14 INFO - 2015-11-23 13:01:14,363 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53187/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53187/tests/dromaeo/cssquery-prototype.html) 13:01:14 INFO - 2015-11-23 13:01:14,949 DEBUG : BROWSER_OUTPUT: RSS: Main: 324648960 13:01:14 INFO - 2015-11-23 13:01:14,949 DEBUG : BROWSER_OUTPUT: 13:04:17 INFO - 2015-11-23 13:04:17,941 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53187/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53187/tests/dromaeo/cssquery-yui.html) 13:04:18 INFO - 2015-11-23 13:04:18,560 DEBUG : BROWSER_OUTPUT: RSS: Main: 325607424 13:04:18 INFO - 2015-11-23 13:04:18,560 DEBUG : BROWSER_OUTPUT: 13:07:21 INFO - 2015-11-23 13:07:21,046 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53187/tests/dromaeo/cssquery-yui.html (next: http://localhost:53187/tests/dromaeo/cssquery-dojo.html) 13:07:21 INFO - 2015-11-23 13:07:21,297 DEBUG : BROWSER_OUTPUT: RSS: Main: 374939648 13:07:21 INFO - 2015-11-23 13:07:21,297 DEBUG : BROWSER_OUTPUT: 13:07:21 INFO - 2015-11-23 13:07:21,297 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:07:21 INFO - 2015-11-23 13:07:21,297 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:07:21 INFO - 2015-11-23 13:07:21,298 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:07:21 INFO - 2015-11-23 13:07:21,298 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:07:21 INFO - 2015-11-23 13:07:21,301 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3368.107451525346;3480.8781692640764;3518.4018716818136;3520.06718219672;3541.433370660694;5711.8000869969555;5853.531717462603;5980.940190598093;5982.551308651852;5995.880082398349;5812.912806307909;5859.091840764689;5876.706164691759;5877.764889404419;5899.233099697044;5282.286891269678;5313.814016509404;5364.409914909357;5364.678119312854;5396.946030539703;5397.217403476494;5405.27028851104;5405.37838148614;5413.106837371829;5418.349798024243;4639.257718764999;4783.641226907978;5116.462771408986;5396.244525766396;5409.29679141711;5389.946100539003;5405.00007498612;5405.486478784509;5409.080456322396;5409.945900541023;4602.6422205449135;5056.443791182967;5170.560502357304;5254.737263136828;5350.866228344284;5961.552883533753;6069.817905462844;6077;6088.96955515224;6090.786822461193;6243.500519958392;6285.717142728588;6312.621242725405;6314.242290925118;6339.302676705559;6162.075688646694;6217.347178546278;6261.530385221126;6267.373262673742;6330.778422755181;5239.502247286502;6075.210222671025;6081.574289799716;6115.4801841843055;6115.48018418435;6498.090267362573;6499.707513161825;6500;6509;6515.413612774778;6110.777844431132;6172.321044685081;6233.438990490878;6238.033104868752;6307.621542707452;6336.144620476177;6357.777477788255;6361.681915904186;6373.139626150503;6379.234491861006;6228.34602366754;6290;6304.432601065926;6306.180196574508;6320.494360451153;5954.583179177503;6165.075238714139;6167.907481387782;6231.4391704746795;6290.119383286344;5065.366829146356;5083.339165908482;5086.135356989321;5093.847184584469;5131.409887862869;4521.276595744731;4522.909541809146;4528.88677783058;4540.841070562515;4542.772861356919;5770.682612456271;5883.323417807007;5904.350521442638;5905;6002.09968504719;6344.936550634527;6418.1656384669695;6422.8715425691225;6430.903536446957;6433.581817181962;6030.969845150834;6045.153678485016;6080.7871724490315;6085.421884920926;6092.969535152296;5403.891922161613;5427.48438898304;5499.890002199933;5504.422035686275;5610.158476228598;6311.936880631227;6350.301466838551;6351.2060992375955;6364.331745166876;6481.805545833632;6372.36276372359;6372.36276372359;6379.170707807955;6383.776567820104;6397.936020639734;6519.511036672364;6539.901901471387;6550.803475895731;6563.982582699689;6580.1116849224745;5579.804706835242;6187.3503282154725;6251.624902505682;6316.273628532594;6324.841878953063;6224;6359.936400636119;6368.203974503187;6388.68056597159;6392.296847346881;5155.819546315861;6314.905276420765;6333.2716737575765;6356.4279214870885;6367.299597044229;5620.594851287178;5877.823665290048;6117.143599896107;6154.292256390393;6309.463695585927;6096.266235377076;6098.361960870079;6108.251008765869;6109.991851344478;6130.01919692847;6308.306086330592;6328.493720502257;6337.397947195009;6338.049292606146;6361.459275961595;5962.642241465526;6053.788117415869;6073.149759033827;6118.938810611837;6178.474829639531 13:07:21 INFO - 2015-11-23 13:07:21,301 DEBUG : BROWSER_OUTPUT: |1;ext.html;552.1827695011385;562.1371195215345;581.9931518473039;582.7581553655233;601.4827248566232;32343.191420214476;32734.67265327349;40837.59162408379;41385.172296554054;41414.58585414152;44064.77967610158;44441;44600.553994460046;44614.55385446153;44656.55343446573;8617.009043959963;9657.17913977311;9845.36005159666;9845.950770246138;9855.605775768961;8803.911960880405;8890.421777684463;9711.174550163245;11861.822072668916;11876.703082422922;11655.708607284843;11726;11736.882631173707;11746;11752.7649447011;8919.286457083417;9014.233790127848;11704.239224450426;11744.706382340424;11772.529098836036;8783.516906570136;11675.12436567261;11812;11819.054475641928;11824.52701891932;41093.38359924604;41399;41475.75572732823;41478.96302592429;41479.963000924916;3230.8223047732367;3369.2587630721446;3377.5440315557576;3848.8460461581503;3897.824597893073;23444.600532922803;28974.13077607654;29452.96914608;29508.852455737582;29518.40963180746;2786.3730660601404;2826.2651710555406;2872.755815755663;2926.502494575906;2979.2998645318335;465797;466219;467224;467712;467882;57724;58368;58658.41341586615;67874;68552;68971.65514172497;69164.3083569168;69957;70027.64986175037;70175.64912175406;16540.421085261958;16730.581735456468;16761.580960476087;16773;16774.580635483966;12685.492580296685;12718.745625087631;12753.617391478085;12771.425285862158;12975;15384.692306153815;16817.747733784003;20616.896915515626;20652;21154.471138221666;7823.374130069581;8671.956640216758;8676.392652514389;8928.419652722552;8930.776730581787;965.9661911833052;998.7902540466583;1046.3564907581783;1084.4848696868924;1091.770728147098;29558.556621650692;30744.231394215323;31116.68883311138;31583.52624710631;31857;1003.3177439341318;1029.5469993202967;1073.1682945717132;1074.5755426606604;1125.7016890524017;14877.553673389815;14931.850681493046;15025.417247739544;15045.473408430653;15101.622459438602;549978;551867.9252829842;552997;553961;555855;45737;58617;58670.70664646735;58715.53211169755;58797;1457.8104846370115;1461.335092532895;1479.2603698150924;1491.5450787509697;1493.865552100316;29348.11955641334;30023.399532009673;30276.54585181268;30374.392512149192;30740.846295769272;50199.74900125622;51220.71948201325;54129.18806217831;54538.181927271915;54565.72717136389;389059;527302;532708;534419;535266.7969863109;30780.84609576938;31141.065768026994;31144;31149.844250778602;31188;43201.35197972096;43769.90575235645;43789.56210437855;44335;45014.77492612516;36730.26539469249;36918.630813692595;37349.62650373462;38686.419703703905;39344;36746.448803267434;37003.62996370002;37937.43093853539;38094.428583571826;38181.42727859029;36954.63045369512;37711.49154033808;38014;38039.42940855834;38073.42889856599;31998.68001319957;33377.165570860925;33654;33772.32455350929;33902.81340153083;24973.375665608506;25044.62433063469;25175.74824251807;25629.615555766304;25660.358491037874 13:07:21 INFO - 2015-11-23 13:07:21,304 DEBUG : BROWSER_OUTPUT: |2;jquery.html;335.2273010710313;346.4456869009583;360.4575114452748;370.5386793442165;375.0847931048242;16712.41506547271;17864.28542858284;20120;20700.378988630346;21416.89291553542;21870;21903.233386831464;22434.88782556085;22440.32679019632;22440.887795561;6426.485881129498;6580.243272023707;6591.703373348211;6593.20881494219;6603.372679595454;3894.532656081274;4039.8788036358956;4044.373122166069;5800.9129863052085;6597.274299827015;5936.5547583931375;5938.435848594377;5952.136940143677;5960.374160713128;5966.284045914496;6148.907766383508;6464.353564643545;6466.838329041764;6472.158619379497;6480.088373929679;5409.918851217196;5681.659100453986;5691.573132015074;5694.259746233005;5720;12833.165844220095;12849.486020559167;12995.870041299655;13019.414126364336;13059.869401306056;2163.6862654915108;2199.065397206181;2209.591225623265;2214.745304290011;2242.6972358731687;9946.154576860976;10082.69751907444;10391.480425978747;11938.343391113485;14550.708985820223;1699.065513967313;1706.9487915362558;1738.2612389734313;1771.070188151231;1805.3500739733686;99172;102960.97039029664;103663;104448;105810;11122.165837562216;11123.555057797597;11129.332240065622;11132.49903754333;11242.7189320266;13235.735285294433;13318.467261309439;13344.532941347006;13346.799798003038;13358.332083395791;7444.925550744531;7810;7865.820126980999;8571.442856214326;8581;8374.2881855043;8752.56237188138;8765.693200737944;8840.204381605558;8856.335774816915;4272.957270427318;4319.568043195655;4333.783310834446;4360.956390436118;4389.517153113155;1424.672325365151;1693.8306169382963;1766.2493440288083;1766.8586513078924;1769.6991511443086;920.3741455810114;949.2168960607527;980.7940332530106;989.4459102902398;1004.7488127968008;19648.70526942097;19829;20282;20700.171993120406;21150.83670398143;839.5214727605206;913.6436789652041;917.3899356927702;981.3081777346953;986.5461887531673;10362.689119326282;10681.438231404516;10685.358878467317;10702.357858528514;10740.677779666623;778019;785493.3781290768;789088;792759.0362048153;795039;126767;129707;132714;133232.00151997534;133895.3305233487;1170.151640060966;1171.7305019845312;1244.1788419643174;1247.108317552954;1289.3939848271298;16379.836201638307;18053.819461805215;18734.25062997465;18871.90564047171;18961;44132.11735765331;45633.543664564255;49825.00349992907;50924;51046;63481.047784284194;64288.678556606916;64624.353756463715;65858.67070664807;66153.35386584482;4315.676324275754;9485.762855928657;9642.878566715312;9921.55353009102;9948.204143668634;11936.701582460508;12047.698807529532;16612.83387166113;21333.146674132862;21336.826474543428;16009.919950400174;16092;16235.918820405823;16467.01197928128;16613.667726645643;15566.766498502306;15915;16152.192390380198;16201.837981620505;16775.832241677916;11310.830337545109;13235.66910827237;13253.66865828362;16815.327386904388;17123.22945467432;9517.048295170427;9667.226621870373;9694.660686875926;9729.70810875675;9784.266180036384;10111.191104711752;10212.08091271789;13706.451741930212;15762.054276743433;16248.91875540662 13:07:21 INFO - 2015-11-23 13:07:21,305 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1646.3003223629958;1658.6019355354715;1671.5069054628884;1940.8932508712014;1979.079727926514;7253.347198752112;7590.810229744259;8304.584770761468;8391.832163356745;8432.704855330065;6572.507061970347;8237.299829514484;8239.876401853962;8309.875351869727;8313.293370063537;2087.728595282611;2131.6482780341225;2361.1499860050367;2378.666986621866;2389.259329607827;2159.4817243861517;2164.956700865982;2171.0881429799524;2356.905723771047;2387.319613910036;2320.477892474197;2355.0815182079004;2355.6702061711376;2361.244401791427;2363.52729454109;2346.272655476808;2379.7977171940406;2382.094803974487;2392.605220138675;2394.1381102802975;2133.765285818559;2172.8261739060836;2175.423512769117;2356.4815740537056;2398.8080953523677;8189.7133600323705;8322.375821813388;8322.542260175687;8325.750227493185;8328.50028998256;5202.7918883245;5248.265242866002;5277.656952298127;5294.047071527124;5298.655587386807;3393.4570468724887;3403.3533628610485;3450.2064525159103;3592.209713862946;3599.3881040223223;1004.0311099788739;1030.5311083457009;1031.3502493429166;1037.6316407675242;1046.785408991155;10627.14982801374;10887.891121088845;10935.671929842118;10963.232573719843;10968.067714244298;4459.509453960061;4499.167653984024;4561.749103799323;4580.564846339593;4590.747508886977;9065.365424420228;9096.54517274147;9106.952700439402;9110.225630821455;9112.088791120967;5165.48345165488;5188.299579556787;5196.480351964773;5202.895942081137;5206.5314121729225;4787.976060119677;4811.518848115161;4819.831305904347;4832.033593281358;4833.3958255218095;3093.443180227536;3547.2550764339776;3607.152319204985;3634.6183650716293;3676.926461470809;1112.844201811747;1131.7340425000118;1138.9544418223345;1139.88601139887;1141.1840534018052;1339.8794108530278;1343.623785340087;1355.0650051464459;1384.8684374984562;1405.5994041698068;7931.405144614177;7936.563489008045;7967.04395472547;7970.880436793453;7981.281684648294;496.9403671559436;501.79928028788777;503.0542579949744;507.9492050794965;509.9796008159706;5693.089105743061;6073.544484163705;6182.041783523561;6247.032184861754;6269.968650156811;9517.666881659108;9570.234381249484;9702;9751.878533968542;9753;9517.904820951702;9595.13643772064;9637.132658060807;9827.606895724233;9902.158316543031;7726.188750181263;7859;7865.292123708779;7878.606069696492;7938.880916786253;7789.1821358756515;7828.138904720362;7829.491083079582;7888.290053895177;7892.36861051103;7438.851222975402;8978.820423591622;9016.233620142099;9091.818163636823;9156.816863662556;7362.3741981932135;9178.036306187754;9365.11031452011;9517.571709273238;9531.523423828643;7260.600666963368;7307.890381644173;7308.634568271672;7427.4800763946005;7442.7395041173295;7943.602819859099;8002.759917202493;8011.759647210593;8019.679212831421;8020.799480013046;6084.726187321669;7278.526895751759;7387.224341444071;7521.5111017783665;7640.579768112807;7260;7260.4554658399775;7319.414446844133;7394.371478424179;7415.369693576106;7375.409967202503;7413.073365829271;7443.888341674771;7469.290417410337;7509;5901.704914754331;6789;6838.042674025541;6853.828654283483;6871.381575658214;6776.559523630948;6802.0477133202385;6825.488088393291;6872.725090996504;6883.7590684325805 13:07:21 INFO - 2015-11-23 13:07:21,309 DEBUG : BROWSER_OUTPUT: |4;prototype.html;324.1183979575555;326.9542264083029;333.7780376049927;334.20459306849693;339.1893374834147;6894.655267236643;6896.689648965802;6898.1377327834025;6909.101816763826;6929.445644348452;5529.281193444856;6876.724931002754;6877.002834588981;6899.793006209809;6912.101426814507;4924.138275801738;5023.874403139924;5036.974815125937;5060.06388818068;5062.291279220912;5031.471695471978;5042.268871013701;5067;5084.3644544431945;5105.566026887719;5023.397192336906;5031.11955407804;5043.193089105744;5055.064813009605;5057.468965758598;4826.34844296019;4961.082199793013;4967.081089998362;4981.37732783402;5047.899042019158;4324.589164029412;4342.023044814923;4348.152110338485;4361.389405483234;4363.367311739812;6605.339466053404;6618.040384144272;6618.503612229054;6618.536702430832;6656.733730650768;5518.227448157261;5533.806316778893;5714.285714285715;5931.555133365015;5932.525397968152;7386.187519372865;7404;7405.333519983174;7408.222136675679;7423.962880185564;4877.122118018755;4881.6338774591695;4883.731394773286;4885.7312847793355;4897.485763994765;7568.4323675724545;7858.607069646495;7877.6848926042885;7890.447668663196;7897.407694422941;4975;4978.8257410990445;4984.2025275955675;4985.376827896513;4993.525615066563;5034.144195486776;5066.164082926276;5066.581357219984;5074.264231686385;5086.516780905808;5800.767969281266;6013.849653758603;6015.729292181775;6016.608920420159;6021.976264035125;6026.306974697965;7369.852602948018;7429;7446;7447.441441891771;1738.965220695579;1762.903040332794;1763.8765286430084;1764.673535395956;1769;998.6953979036318;1007.6976906927893;1037.9931466477506;1126.5831642292405;1136.0286954653652;6449.226092868792;7032.331928466788;7058.647067646597;7061.6469176542;7081.468889833283;7693.307602315706;7696.961515192388;7710.151883292833;7712.5758083305955;7726.7681969541;6853.211880633691;7022.719091236396;7036.718531258693;7043.436525077981;7086.00795888576;3768.6042965488227;4074.796260186979;4094.713370064067;4095.1400205957084;4102.589741025873;6449.129367535416;7510.399168066541;8034.879476807852;8037.477563958324;8049.993750781152;7221.73619616565;7348.889766653505;7545.471816972759;7836.059672839182;7960.641771120314;6708.932910670928;7230.493865429475;8083.353331733447;8084.312833409226;8108.472949258279;7726.652300646372;7730.072391313079;7738.92261077382;7738.961305193438;7745.806354841174;7346.77959661211;7597;7603.467757256939;7610.771676849703;7611.162772095176;8051.758447246592;8062.879056814035;8066.23370779775;8070.919290807017;8075.5558444286125;4765.8093676252565;4940.481249468754;4941.43173535048;4951.777170027285;4953.430355509163;6218.471429928507;7697.730579429693;7698.384129269533;7701.152873183833;7740.92259077402;7390.334869861738;7409.962950185214;7411.4070874331;7415.5179913305465;7423.517471364344;7194.820129496805;7392.556446613005;7395;7452.21751716062;7486.588237646763;7269.164046134762;7277.672504737406;7283.417326613964;7286.089238845145;7310.707571697072;7264.709411623476;7477.401807855467;7484;7490.550566966;7495.138059123271;7311.195768465571;7323.2676732326345;7327.816804579928;7330.743423980135;7343.816404589928 13:07:21 INFO - 2015-11-23 13:07:21,309 DEBUG : BROWSER_OUTPUT: |5;yui.html;709.8473828126952;713.5362014690451;746.4401698725956;776.103600341605;785.1441928298156;18379.816201837977;18635.068246587685;18678.719819202724;18698.15858286377;18758.34345797899;16716;16803;16828.990260584374;16846.410375636857;16915.1542422879;778.1090651204368;786.0685088170536;787.9606019699021;789.7907054630527;924.6024209589874;956.2636769687336;961.9326647134703;975.2539307429822;977.5014742481314;978.2565250409705;1017.694691592523;1020.9438480883548;1022.4427686910615;1022.6318525330912;1023.2274632652337;798.0981490915258;809.3242142810731;809.8623234050167;811.7686459359113;1014.90865822076;745.3589912675095;763.1224092293851;763.9465237433382;765.1697907770076;765.4641750774424;15581.688366232613;15702;15774.842251577453;15785.68428631421;15798;12587.559435419807;12918.22490650564;12925.224486530838;13076.607701768962;13104.934475327562;10091.444970526618;10226.181905447545;10353.637622683245;10379.221558383077;11141.610043648514;3544.6455354464347;3598.5321908152036;3599.2621512590117;3612.1692010837655;3613.7470377073614;75934.62032689857;78163;79812.40375192522;81817.18182818155;85231.5738421304;7969.641366138421;9879.357841740264;9881;9908.603655853829;10037.096661300518;18977.620447590973;22883.31350059501;23064.308070757903;23098;23130.53738925212;7580.620968951531;7723.459357845009;7905.881411778828;8010.198980101944;8020.839583208303;4114.259433301974;4133.731307465006;4191.161767646483;4245.172191422643;4268.679849011337;3537.699295559855;3580.480830279595;3585.5697316321684;3589.9282014359565;3593.2813437312643;595.3213336796056;601.9187409699634;632.6836581709146;648.5881465269588;657.7763560389491;476.95945844603597;497.572088004316;501.5486062543667;529.1348644965509;587.9735411906474;6741.460683145337;8708.390412671179;8722.520261385685;8849.115088491228;8947.418417802952;510.81745758569537;543.9048166570834;577.4918072096613;603.7403916315939;625.7528276330914;3918.7256892017285;4029.5164580250557;4050.311447054008;4138.399932009842;4165.8958526037095;104417;106429;107402;107511.46244268885;107994;80570;82053;83521.16478835256;84457;86156.13843861606;73589.63205183939;74106.6294668534;74154.99999999892;74633.25366746372;75853.24146758571;8907.821843563223;8921.553922303989;9084.727458176265;9200.861987070333;9277.721668349961;42120.157596848505;51116;51178.74410627923;55639.165412518036;55763;59687;60934.69532652486;62295.37704623077;63048.68475657592;63216.36783632105;9219.202255560102;9767.755806104904;10607.461918021998;11538.019268361948;11966.581169659368;11948.581799636971;12189.817152742893;12226.388680566113;12251.69370765738;12257.754844902873;11555;11672.70818229551;11683.941580292045;11684.591039313584;11707.590234341757;11562.190646654653;11662.70843228926;11732.765344692887;11745.588904388647;11747.647570572897;11376.203665743318;11420.257683250562;11489.195756297313;11496.82754758696;11508.53965841357;9776.21790256792;10253.743656408351;10292.845607316047;10298.536565854705;10304.227182961458;9797.167240784613;9931.503424828585;10051.798964020825;10112;10126.898731012596 13:07:21 INFO - 2015-11-23 13:07:21,309 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:07:21 INFO - 2015-11-23 13:07:21,309 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:07:21 INFO - 2015-11-23 13:07:21,310 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1103 13:07:21 INFO - 2015-11-23 13:07:21,310 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:07:21 INFO - 2015-11-23 13:07:21,310 DEBUG : BROWSER_OUTPUT: __startTimestamp1448312841296__endTimestamp 13:07:21 INFO - 2015-11-23 13:07:21,310 DEBUG : BROWSER_OUTPUT: 13:07:21 INFO - 2015-11-23 13:07:21,310 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:07:21 INFO - 2015-11-23 13:07:21,310 DEBUG : BROWSER_OUTPUT: Number of tests: 6 13:07:21 INFO - 2015-11-23 13:07:21,310 DEBUG : BROWSER_OUTPUT: 13:07:21 INFO - 2015-11-23 13:07:21,310 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5864.72 Median:6098.36 stddev:660.05 (10.8%) stddev-sans-first:632.35 13:07:21 INFO - 2015-11-23 13:07:21,312 DEBUG : BROWSER_OUTPUT: Values: 3368.1 3480.9 3518.4 3520.1 3541.4 5711.8 5853.5 5980.9 5982.6 5995.9 5812.9 5859.1 5876.7 5877.8 5899.2 5282.3 5313.8 5364.4 5364.7 5396.9 5397.2 5405.3 5405.4 5413.1 5418.3 4639.3 4783.6 5116.5 5396.2 5409.3 5389.9 5405.0 5405.5 5409.1 5409.9 4602.6 5056.4 5170.6 5254.7 5350.9 5961.6 6069.8 6077.0 6089.0 6090.8 6243.5 6285.7 6312.6 6314.2 6339.3 6162.1 6217.3 6261.5 6267.4 6330.8 5239.5 6075.2 6081.6 6115.5 6115.5 6498.1 6499.7 6500.0 6509.0 6515.4 6110.8 6172.3 6233.4 6238.0 6307.6 6336.1 6357.8 6361.7 6373.1 6379.2 6228.3 6290.0 6304.4 6306.2 6320.5 5954.6 6165.1 6167.9 6231.4 6290.1 5065.4 5083.3 5086.1 5093.8 5131.4 4521.3 4522.9 4528.9 4540.8 4542.8 5770.7 5883.3 5904.4 5905.0 6002.1 6344.9 6418.2 6422.9 6430.9 6433.6 6031.0 6045.2 6080.8 6085.4 6093.0 5403.9 5427.5 5499.9 5504.4 5610.2 6311.9 6350.3 6351.2 6364.3 6481.8 6372.4 6372.4 6379.2 6383.8 6397.9 6519.5 6539.9 6550.8 6564.0 6580.1 5579.8 6187.4 6251.6 6316.3 6324.8 6224.0 6359.9 6368.2 6388.7 6392.3 5155.8 6314.9 6333.3 6356.4 6367.3 5620.6 5877.8 6117.1 6154.3 6309.5 6096.3 6098.4 6108.3 6110.0 6130.0 6308.3 6328.5 6337.4 6338.0 6361.5 5962.6 6053.8 6073.1 6118.9 6178.5 13:07:21 INFO - 2015-11-23 13:07:21,312 DEBUG : BROWSER_OUTPUT: 13:07:21 INFO - 2015-11-23 13:07:21,312 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:65564.39 Median:36979.13 stddev:135703.38 (367.0%) stddev-sans-first:135996.28 13:07:21 INFO - 2015-11-23 13:07:21,313 DEBUG : BROWSER_OUTPUT: Values: 552.2 562.1 582.0 582.8 601.5 32343.2 32734.7 40837.6 41385.2 41414.6 44064.8 44441.0 44600.6 44614.6 44656.6 8617.0 9657.2 9845.4 9846.0 9855.6 8803.9 8890.4 9711.2 11861.8 11876.7 11655.7 11726.0 11736.9 11746.0 11752.8 8919.3 9014.2 11704.2 11744.7 11772.5 8783.5 11675.1 11812.0 11819.1 11824.5 41093.4 41399.0 41475.8 41479.0 41480.0 3230.8 3369.3 3377.5 3848.8 3897.8 23444.6 28974.1 29453.0 29508.9 29518.4 2786.4 2826.3 2872.8 2926.5 2979.3 465797.0 466219.0 467224.0 467712.0 467882.0 57724.0 58368.0 58658.4 67874.0 68552.0 68971.7 69164.3 69957.0 70027.6 70175.6 16540.4 16730.6 16761.6 16773.0 16774.6 12685.5 12718.7 12753.6 12771.4 12975.0 15384.7 16817.7 20616.9 20652.0 21154.5 7823.4 8672.0 8676.4 8928.4 8930.8 966.0 998.8 1046.4 1084.5 1091.8 29558.6 30744.2 31116.7 31583.5 31857.0 1003.3 1029.5 1073.2 1074.6 1125.7 14877.6 14931.9 15025.4 15045.5 15101.6 549978.0 551867.9 552997.0 553961.0 555855.0 45737.0 58617.0 58670.7 58715.5 58797.0 1457.8 1461.3 1479.3 1491.5 1493.9 29348.1 30023.4 30276.5 30374.4 30740.8 50199.7 51220.7 54129.2 54538.2 54565.7 389059.0 527302.0 532708.0 534419.0 535266.8 30780.8 31141.1 31144.0 31149.8 31188.0 43201.4 43769.9 43789.6 44335.0 45014.8 36730.3 36918.6 37349.6 38686.4 39344.0 36746.4 37003.6 37937.4 38094.4 38181.4 36954.6 37711.5 38014.0 38039.4 38073.4 31998.7 33377.2 33654.0 33772.3 33902.8 24973.4 25044.6 25175.7 25629.6 25660.4 13:07:21 INFO - 2015-11-23 13:07:21,313 DEBUG : BROWSER_OUTPUT: 13:07:21 INFO - 2015-11-23 13:07:21,313 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:39719.37 Median:21886.62 stddev:129764.18 (592.9%) stddev-sans-first:130094.50 13:07:21 INFO - 2015-11-23 13:07:21,315 DEBUG : BROWSER_OUTPUT: Values: 335.2 346.4 360.5 370.5 375.1 16712.4 17864.3 20120.0 20700.4 21416.9 21870.0 21903.2 22434.9 22440.3 22440.9 6426.5 6580.2 6591.7 6593.2 6603.4 3894.5 4039.9 4044.4 5800.9 6597.3 5936.6 5938.4 5952.1 5960.4 5966.3 6148.9 6464.4 6466.8 6472.2 6480.1 5409.9 5681.7 5691.6 5694.3 5720.0 12833.2 12849.5 12995.9 13019.4 13059.9 2163.7 2199.1 2209.6 2214.7 2242.7 9946.2 10082.7 10391.5 11938.3 14550.7 1699.1 1706.9 1738.3 1771.1 1805.4 99172.0 102961.0 103663.0 104448.0 105810.0 11122.2 11123.6 11129.3 11132.5 11242.7 13235.7 13318.5 13344.5 13346.8 13358.3 7444.9 7810.0 7865.8 8571.4 8581.0 8374.3 8752.6 8765.7 8840.2 8856.3 4273.0 4319.6 4333.8 4361.0 4389.5 1424.7 1693.8 1766.2 1766.9 1769.7 920.4 949.2 980.8 989.4 1004.7 19648.7 19829.0 20282.0 20700.2 21150.8 839.5 913.6 917.4 981.3 986.5 10362.7 10681.4 10685.4 10702.4 10740.7 778019.0 785493.4 789088.0 792759.0 795039.0 126767.0 129707.0 132714.0 133232.0 133895.3 1170.2 1171.7 1244.2 1247.1 1289.4 16379.8 18053.8 18734.3 18871.9 18961.0 44132.1 45633.5 49825.0 50924.0 51046.0 63481.0 64288.7 64624.4 65858.7 66153.4 4315.7 9485.8 9642.9 9921.6 9948.2 11936.7 12047.7 16612.8 21333.1 21336.8 16009.9 16092.0 16235.9 16467.0 16613.7 15566.8 15915.0 16152.2 16201.8 16775.8 11310.8 13235.7 13253.7 16815.3 17123.2 9517.0 9667.2 9694.7 9729.7 9784.3 10111.2 10212.1 13706.5 15762.1 16248.9 13:07:21 INFO - 2015-11-23 13:07:21,315 DEBUG : BROWSER_OUTPUT: 13:07:21 INFO - 2015-11-23 13:07:21,315 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5720.52 Median:6258.50 stddev:2971.12 (47.5%) stddev-sans-first:2963.68 13:07:21 INFO - 2015-11-23 13:07:21,315 DEBUG : BROWSER_OUTPUT: Values: 1646.3 1658.6 1671.5 1940.9 1979.1 7253.3 7590.8 8304.6 8391.8 8432.7 6572.5 8237.3 8239.9 8309.9 8313.3 2087.7 2131.6 2361.1 2378.7 2389.3 2159.5 2165.0 2171.1 2356.9 2387.3 2320.5 2355.1 2355.7 2361.2 2363.5 2346.3 2379.8 2382.1 2392.6 2394.1 2133.8 2172.8 2175.4 2356.5 2398.8 8189.7 8322.4 8322.5 8325.8 8328.5 5202.8 5248.3 5277.7 5294.0 5298.7 3393.5 3403.4 3450.2 3592.2 3599.4 1004.0 1030.5 1031.4 1037.6 1046.8 10627.1 10887.9 10935.7 10963.2 10968.1 4459.5 4499.2 4561.7 4580.6 4590.7 9065.4 9096.5 9107.0 9110.2 9112.1 5165.5 5188.3 5196.5 5202.9 5206.5 4788.0 4811.5 4819.8 4832.0 4833.4 3093.4 3547.3 3607.2 3634.6 3676.9 1112.8 1131.7 1139.0 1139.9 1141.2 1339.9 1343.6 1355.1 1384.9 1405.6 7931.4 7936.6 7967.0 7970.9 7981.3 496.9 501.8 503.1 507.9 510.0 5693.1 6073.5 6182.0 6247.0 6270.0 9517.7 9570.2 9702.0 9751.9 9753.0 9517.9 9595.1 9637.1 9827.6 9902.2 7726.2 7859.0 7865.3 7878.6 7938.9 7789.2 7828.1 7829.5 7888.3 7892.4 7438.9 8978.8 9016.2 9091.8 9156.8 7362.4 9178.0 9365.1 9517.6 9531.5 7260.6 7307.9 7308.6 7427.5 7442.7 7943.6 8002.8 8011.8 8019.7 8020.8 6084.7 7278.5 7387.2 7521.5 7640.6 7260.0 7260.5 7319.4 7394.4 7415.4 7375.4 7413.1 7443.9 7469.3 7509.0 5901.7 6789.0 6838.0 6853.8 6871.4 6776.6 6802.0 6825.5 6872.7 6883.8 13:07:21 INFO - 2015-11-23 13:07:21,315 DEBUG : BROWSER_OUTPUT: 13:07:21 INFO - 2015-11-23 13:07:21,316 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:6049.61 Median:6898.97 stddev:1928.33 (28.0%) stddev-sans-first:1885.24 13:07:21 INFO - 2015-11-23 13:07:21,316 DEBUG : BROWSER_OUTPUT: Values: 324.1 327.0 333.8 334.2 339.2 6894.7 6896.7 6898.1 6909.1 6929.4 5529.3 6876.7 6877.0 6899.8 6912.1 4924.1 5023.9 5037.0 5060.1 5062.3 5031.5 5042.3 5067.0 5084.4 5105.6 5023.4 5031.1 5043.2 5055.1 5057.5 4826.3 4961.1 4967.1 4981.4 5047.9 4324.6 4342.0 4348.2 4361.4 4363.4 6605.3 6618.0 6618.5 6618.5 6656.7 5518.2 5533.8 5714.3 5931.6 5932.5 7386.2 7404.0 7405.3 7408.2 7424.0 4877.1 4881.6 4883.7 4885.7 4897.5 7568.4 7858.6 7877.7 7890.4 7897.4 4975.0 4978.8 4984.2 4985.4 4993.5 5034.1 5066.2 5066.6 5074.3 5086.5 5800.8 6013.8 6015.7 6016.6 6022.0 6026.3 7369.9 7429.0 7446.0 7447.4 1739.0 1762.9 1763.9 1764.7 1769.0 998.7 1007.7 1038.0 1126.6 1136.0 6449.2 7032.3 7058.6 7061.6 7081.5 7693.3 7697.0 7710.2 7712.6 7726.8 6853.2 7022.7 7036.7 7043.4 7086.0 3768.6 4074.8 4094.7 4095.1 4102.6 6449.1 7510.4 8034.9 8037.5 8050.0 7221.7 7348.9 7545.5 7836.1 7960.6 6708.9 7230.5 8083.4 8084.3 8108.5 7726.7 7730.1 7738.9 7739.0 7745.8 7346.8 7597.0 7603.5 7610.8 7611.2 8051.8 8062.9 8066.2 8070.9 8075.6 4765.8 4940.5 4941.4 4951.8 4953.4 6218.5 7697.7 7698.4 7701.2 7740.9 7390.3 7410.0 7411.4 7415.5 7423.5 7194.8 7392.6 7395.0 7452.2 7486.6 7269.2 7277.7 7283.4 7286.1 7310.7 7264.7 7477.4 7484.0 7490.6 7495.1 7311.2 7323.3 7327.8 7330.7 7343.8 13:07:21 INFO - 2015-11-23 13:07:21,316 DEBUG : BROWSER_OUTPUT: 13:07:21 INFO - 2015-11-23 13:07:21,316 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:19152.29 Median:23182.66 stddev:27202.09 (117.3%) stddev-sans-first:27243.15 13:07:21 INFO - 2015-11-23 13:07:21,318 DEBUG : BROWSER_OUTPUT: Values: 709.8 713.5 746.4 776.1 785.1 18379.8 18635.1 18678.7 18698.2 18758.3 16716.0 16803.0 16829.0 16846.4 16915.2 778.1 786.1 788.0 789.8 924.6 956.3 961.9 975.3 977.5 978.3 1017.7 1020.9 1022.4 1022.6 1023.2 798.1 809.3 809.9 811.8 1014.9 745.4 763.1 763.9 765.2 765.5 15581.7 15702.0 15774.8 15785.7 15798.0 12587.6 12918.2 12925.2 13076.6 13104.9 10091.4 10226.2 10353.6 10379.2 11141.6 3544.6 3598.5 3599.3 3612.2 3613.7 75934.6 78163.0 79812.4 81817.2 85231.6 7969.6 9879.4 9881.0 9908.6 10037.1 18977.6 22883.3 23064.3 23098.0 23130.5 7580.6 7723.5 7905.9 8010.2 8020.8 4114.3 4133.7 4191.2 4245.2 4268.7 3537.7 3580.5 3585.6 3589.9 3593.3 595.3 601.9 632.7 648.6 657.8 477.0 497.6 501.5 529.1 588.0 6741.5 8708.4 8722.5 8849.1 8947.4 510.8 543.9 577.5 603.7 625.8 3918.7 4029.5 4050.3 4138.4 4165.9 104417.0 106429.0 107402.0 107511.5 107994.0 80570.0 82053.0 83521.2 84457.0 86156.1 73589.6 74106.6 74155.0 74633.3 75853.2 8907.8 8921.6 9084.7 9200.9 9277.7 42120.2 51116.0 51178.7 55639.2 55763.0 59687.0 60934.7 62295.4 63048.7 63216.4 9219.2 9767.8 10607.5 11538.0 11966.6 11948.6 12189.8 12226.4 12251.7 12257.8 11555.0 11672.7 11683.9 11684.6 11707.6 11562.2 11662.7 11732.8 11745.6 11747.6 11376.2 11420.3 11489.2 11496.8 11508.5 9776.2 10253.7 10292.8 10298.5 10304.2 9797.2 9931.5 10051.8 10112.0 10126.9 13:07:21 INFO - 2015-11-23 13:07:21,318 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:07:21 INFO - 2015-11-23 13:07:21,318 DEBUG : BROWSER_OUTPUT: 13:07:21 INFO - 2015-11-23 13:07:21,810 INFO : Browser exited with error code: 0 13:07:21 INFO - 2015-11-23 13:07:21,835 INFO : Completed test dromaeo_css (00:18:34) 13:07:21 INFO - 2015-11-23 13:07:21,835 INFO : Starting test kraken 13:07:21 INFO - 2015-11-23 13:07:21,835 DEBUG : operating with platform_type : mac_ 13:07:21 INFO - 2015-11-23 13:07:21,835 INFO : Initialising browser for kraken test... 13:07:21 INFO - 2015-11-23 13:07:21,848 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/tmpWWkTSm/profile http://localhost:53187/getInfo.html 13:07:23 INFO - 2015-11-23 13:07:23,759 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:07:23 INFO - 2015-11-23 13:07:23,760 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:07:23 INFO - 2015-11-23 13:07:23,760 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 13:07:23 INFO - 2015-11-23 13:07:23,760 DEBUG : BROWSER_OUTPUT: __metrics 13:07:23 INFO - 2015-11-23 13:07:23,776 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:07:24 INFO - 2015-11-23 13:07:24,594 INFO : Browser initialized. 13:07:24 INFO - 2015-11-23 13:07:24,594 INFO : Running cycle 1/1 for kraken test... 13:07:24 INFO - 2015-11-23 13:07:24,594 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/tmpWWkTSm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:07:36 INFO - 2015-11-23 13:07:36,502 DEBUG : BROWSER_OUTPUT: RSS: Main: 226385920 13:07:36 INFO - 2015-11-23 13:07:36,502 DEBUG : BROWSER_OUTPUT: 13:07:39 INFO - 2015-11-23 13:07:39,002 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53187/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53187/tests/kraken/driver.html?testName=audio-beat-detection) 13:07:39 INFO - 2015-11-23 13:07:39,594 DEBUG : BROWSER_OUTPUT: RSS: Main: 275722240 13:07:39 INFO - 2015-11-23 13:07:39,594 DEBUG : BROWSER_OUTPUT: 13:07:42 INFO - 2015-11-23 13:07:42,239 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53187/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53187/tests/kraken/driver.html?testName=audio-dft) 13:07:42 INFO - 2015-11-23 13:07:42,829 DEBUG : BROWSER_OUTPUT: RSS: Main: 290807808 13:07:42 INFO - 2015-11-23 13:07:42,829 DEBUG : BROWSER_OUTPUT: 13:07:46 INFO - 2015-11-23 13:07:46,026 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53187/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53187/tests/kraken/driver.html?testName=audio-fft) 13:07:46 INFO - 2015-11-23 13:07:46,606 DEBUG : BROWSER_OUTPUT: RSS: Main: 277688320 13:07:46 INFO - 2015-11-23 13:07:46,606 DEBUG : BROWSER_OUTPUT: 13:07:48 INFO - 2015-11-23 13:07:48,464 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53187/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53187/tests/kraken/driver.html?testName=audio-oscillator) 13:07:49 INFO - 2015-11-23 13:07:49,062 DEBUG : BROWSER_OUTPUT: RSS: Main: 279617536 13:07:49 INFO - 2015-11-23 13:07:49,062 DEBUG : BROWSER_OUTPUT: 13:07:51 INFO - 2015-11-23 13:07:51,064 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53187/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53187/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:07:51 INFO - 2015-11-23 13:07:51,643 DEBUG : BROWSER_OUTPUT: RSS: Main: 280027136 13:07:51 INFO - 2015-11-23 13:07:51,643 DEBUG : BROWSER_OUTPUT: 13:07:54 INFO - 2015-11-23 13:07:54,314 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53187/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53187/tests/kraken/driver.html?testName=imaging-darkroom) 13:07:54 INFO - 2015-11-23 13:07:54,898 DEBUG : BROWSER_OUTPUT: RSS: Main: 281436160 13:07:54 INFO - 2015-11-23 13:07:54,898 DEBUG : BROWSER_OUTPUT: 13:07:57 INFO - 2015-11-23 13:07:57,671 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53187/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53187/tests/kraken/driver.html?testName=imaging-desaturate) 13:07:58 INFO - 2015-11-23 13:07:58,270 DEBUG : BROWSER_OUTPUT: RSS: Main: 281960448 13:07:58 INFO - 2015-11-23 13:07:58,270 DEBUG : BROWSER_OUTPUT: 13:08:01 INFO - 2015-11-23 13:08:01,072 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53187/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53187/tests/kraken/driver.html?testName=json-parse-financial) 13:08:01 INFO - 2015-11-23 13:08:01,673 DEBUG : BROWSER_OUTPUT: RSS: Main: 280965120 13:08:01 INFO - 2015-11-23 13:08:01,673 DEBUG : BROWSER_OUTPUT: 13:08:03 INFO - 2015-11-23 13:08:03,220 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53187/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53187/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:08:03 INFO - 2015-11-23 13:08:03,793 DEBUG : BROWSER_OUTPUT: RSS: Main: 315551744 13:08:03 INFO - 2015-11-23 13:08:03,794 DEBUG : BROWSER_OUTPUT: 13:08:05 INFO - 2015-11-23 13:08:05,568 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53187/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53187/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:08:06 INFO - 2015-11-23 13:08:06,191 DEBUG : BROWSER_OUTPUT: RSS: Main: 316297216 13:08:06 INFO - 2015-11-23 13:08:06,192 DEBUG : BROWSER_OUTPUT: 13:08:08 INFO - 2015-11-23 13:08:08,254 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53187/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53187/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:08:08 INFO - 2015-11-23 13:08:08,844 DEBUG : BROWSER_OUTPUT: RSS: Main: 324218880 13:08:08 INFO - 2015-11-23 13:08:08,844 DEBUG : BROWSER_OUTPUT: 13:08:11 INFO - 2015-11-23 13:08:11,376 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53187/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53187/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:08:11 INFO - 2015-11-23 13:08:11,995 DEBUG : BROWSER_OUTPUT: RSS: Main: 324911104 13:08:11 INFO - 2015-11-23 13:08:11,995 DEBUG : BROWSER_OUTPUT: 13:08:14 INFO - 2015-11-23 13:08:14,382 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53187/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53187/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:08:14 INFO - 2015-11-23 13:08:14,974 DEBUG : BROWSER_OUTPUT: RSS: Main: 323895296 13:08:14 INFO - 2015-11-23 13:08:14,974 DEBUG : BROWSER_OUTPUT: 13:08:16 INFO - 2015-11-23 13:08:16,714 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53187/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53187/tests/kraken/driver.html?testName=ai-astar) 13:08:16 INFO - 2015-11-23 13:08:16,965 DEBUG : BROWSER_OUTPUT: RSS: Main: 384421888 13:08:16 INFO - 2015-11-23 13:08:16,965 DEBUG : BROWSER_OUTPUT: 13:08:16 INFO - 2015-11-23 13:08:16,965 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:08:16 INFO - 2015-11-23 13:08:16,966 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:08:16 INFO - 2015-11-23 13:08:16,966 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:08:16 INFO - 2015-11-23 13:08:16,966 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:08:16 INFO - 2015-11-23 13:08:16,966 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;109;104;109;109;110;100;111;111;110 13:08:16 INFO - 2015-11-23 13:08:16,966 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;152;120;144;156;114;142;167;145;186;116 13:08:16 INFO - 2015-11-23 13:08:16,966 DEBUG : BROWSER_OUTPUT: |2;audio-dft;183;181;177;185;184;185;183;186;186;180 13:08:16 INFO - 2015-11-23 13:08:16,966 DEBUG : BROWSER_OUTPUT: |3;audio-fft;80;65;75;74;56;57;57;70;74;54 13:08:16 INFO - 2015-11-23 13:08:16,966 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;83;84;119;74;75;74;114;74;73;113 13:08:16 INFO - 2015-11-23 13:08:16,966 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;85;86;86;86;86;86;86;86;85;86 13:08:16 INFO - 2015-11-23 13:08:16,966 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;94;94;92;94;94;93;93;93;93;93 13:08:16 INFO - 2015-11-23 13:08:16,966 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;93;142;127;87;84;84;85;87;85;88 13:08:16 INFO - 2015-11-23 13:08:16,966 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;55;55;54;55;54;54;65;54;54 13:08:16 INFO - 2015-11-23 13:08:16,966 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;65;64;64;65;66;66;68;69;67 13:08:16 INFO - 2015-11-23 13:08:16,966 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;83;82;83;83;83;83;82;101;83 13:08:16 INFO - 2015-11-23 13:08:16,967 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;118;130;124;103;118;123;119;113;165;124 13:08:16 INFO - 2015-11-23 13:08:16,967 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;133;126;136;135;135;122;135;135;135;124 13:08:16 INFO - 2015-11-23 13:08:16,967 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;65;64;65;65;65;64;66;72;91;95 13:08:16 INFO - 2015-11-23 13:08:16,967 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:08:16 INFO - 2015-11-23 13:08:16,967 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:08:16 INFO - 2015-11-23 13:08:16,967 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1054 13:08:16 INFO - 2015-11-23 13:08:16,967 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:08:16 INFO - 2015-11-23 13:08:16,967 DEBUG : BROWSER_OUTPUT: __startTimestamp1448312896962__endTimestamp 13:08:16 INFO - 2015-11-23 13:08:16,967 DEBUG : BROWSER_OUTPUT: 13:08:16 INFO - 2015-11-23 13:08:16,968 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:08:16 INFO - 2015-11-23 13:08:16,968 DEBUG : BROWSER_OUTPUT: Number of tests: 14 13:08:16 INFO - 2015-11-23 13:08:16,968 DEBUG : BROWSER_OUTPUT: 13:08:16 INFO - 2015-11-23 13:08:16,968 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.10 Median:109.50 stddev:3.48 (3.2%) stddev-sans-first:3.69 13:08:16 INFO - 2015-11-23 13:08:16,968 DEBUG : BROWSER_OUTPUT: Values: 108.0 109.0 104.0 109.0 109.0 110.0 100.0 111.0 111.0 110.0 13:08:16 INFO - 2015-11-23 13:08:16,968 DEBUG : BROWSER_OUTPUT: 13:08:16 INFO - 2015-11-23 13:08:16,968 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.20 Median:148.50 stddev:23.01 (15.5%) stddev-sans-first:24.23 13:08:16 INFO - 2015-11-23 13:08:16,968 DEBUG : BROWSER_OUTPUT: Values: 152.0 120.0 144.0 156.0 114.0 142.0 167.0 145.0 186.0 116.0 13:08:16 INFO - 2015-11-23 13:08:16,968 DEBUG : BROWSER_OUTPUT: 13:08:16 INFO - 2015-11-23 13:08:16,970 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:183.00 Median:184.50 stddev:2.91 (1.6%) stddev-sans-first:3.08 13:08:16 INFO - 2015-11-23 13:08:16,970 DEBUG : BROWSER_OUTPUT: Values: 183.0 181.0 177.0 185.0 184.0 185.0 183.0 186.0 186.0 180.0 13:08:16 INFO - 2015-11-23 13:08:16,970 DEBUG : BROWSER_OUTPUT: 13:08:16 INFO - 2015-11-23 13:08:16,970 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:66.20 Median:72.00 stddev:9.59 (13.3%) stddev-sans-first:8.77 13:08:16 INFO - 2015-11-23 13:08:16,970 DEBUG : BROWSER_OUTPUT: Values: 80.0 65.0 75.0 74.0 56.0 57.0 57.0 70.0 74.0 54.0 13:08:16 INFO - 2015-11-23 13:08:16,970 DEBUG : BROWSER_OUTPUT: 13:08:16 INFO - 2015-11-23 13:08:16,970 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:88.30 Median:74.00 stddev:19.10 (25.8%) stddev-sans-first:20.16 13:08:16 INFO - 2015-11-23 13:08:16,970 DEBUG : BROWSER_OUTPUT: Values: 83.0 84.0 119.0 74.0 75.0 74.0 114.0 74.0 73.0 113.0 13:08:16 INFO - 2015-11-23 13:08:16,970 DEBUG : BROWSER_OUTPUT: 13:08:16 INFO - 2015-11-23 13:08:16,970 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:85.80 Median:86.00 stddev:0.42 (0.5%) stddev-sans-first:0.33 13:08:16 INFO - 2015-11-23 13:08:16,971 DEBUG : BROWSER_OUTPUT: Values: 85.0 86.0 86.0 86.0 86.0 86.0 86.0 86.0 85.0 86.0 13:08:16 INFO - 2015-11-23 13:08:16,971 DEBUG : BROWSER_OUTPUT: 13:08:16 INFO - 2015-11-23 13:08:16,971 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:93.30 Median:93.50 stddev:0.67 (0.7%) stddev-sans-first:0.67 13:08:16 INFO - 2015-11-23 13:08:16,971 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 92.0 94.0 94.0 93.0 93.0 93.0 93.0 93.0 13:08:16 INFO - 2015-11-23 13:08:16,971 DEBUG : BROWSER_OUTPUT: 13:08:16 INFO - 2015-11-23 13:08:16,971 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.20 Median:86.00 stddev:20.66 (24.0%) stddev-sans-first:21.88 13:08:16 INFO - 2015-11-23 13:08:16,971 DEBUG : BROWSER_OUTPUT: Values: 93.0 142.0 127.0 87.0 84.0 84.0 85.0 87.0 85.0 88.0 13:08:16 INFO - 2015-11-23 13:08:16,971 DEBUG : BROWSER_OUTPUT: 13:08:16 INFO - 2015-11-23 13:08:16,971 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:55.70 Median:55.00 stddev:3.40 (6.2%) stddev-sans-first:3.57 13:08:16 INFO - 2015-11-23 13:08:16,971 DEBUG : BROWSER_OUTPUT: Values: 57.0 55.0 55.0 54.0 55.0 54.0 54.0 65.0 54.0 54.0 13:08:16 INFO - 2015-11-23 13:08:16,971 DEBUG : BROWSER_OUTPUT: 13:08:16 INFO - 2015-11-23 13:08:16,971 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:1.75 (2.7%) stddev-sans-first:1.73 13:08:16 INFO - 2015-11-23 13:08:16,971 DEBUG : BROWSER_OUTPUT: Values: 64.0 65.0 64.0 64.0 65.0 66.0 66.0 68.0 69.0 67.0 13:08:16 INFO - 2015-11-23 13:08:16,971 DEBUG : BROWSER_OUTPUT: 13:08:16 INFO - 2015-11-23 13:08:16,972 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:83.00 stddev:5.82 (7.0%) stddev-sans-first:6.10 13:08:16 INFO - 2015-11-23 13:08:16,972 DEBUG : BROWSER_OUTPUT: Values: 82.0 83.0 82.0 83.0 83.0 83.0 83.0 82.0 101.0 83.0 13:08:16 INFO - 2015-11-23 13:08:16,972 DEBUG : BROWSER_OUTPUT: 13:08:16 INFO - 2015-11-23 13:08:16,972 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.70 Median:123.50 stddev:16.25 (13.2%) stddev-sans-first:17.10 13:08:16 INFO - 2015-11-23 13:08:16,972 DEBUG : BROWSER_OUTPUT: Values: 118.0 130.0 124.0 103.0 118.0 123.0 119.0 113.0 165.0 124.0 13:08:16 INFO - 2015-11-23 13:08:16,972 DEBUG : BROWSER_OUTPUT: 13:08:16 INFO - 2015-11-23 13:08:16,972 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:131.60 Median:135.00 stddev:5.38 (4.0%) stddev-sans-first:5.68 13:08:16 INFO - 2015-11-23 13:08:16,972 DEBUG : BROWSER_OUTPUT: Values: 133.0 126.0 136.0 135.0 135.0 122.0 135.0 135.0 135.0 124.0 13:08:16 INFO - 2015-11-23 13:08:16,972 DEBUG : BROWSER_OUTPUT: 13:08:16 INFO - 2015-11-23 13:08:16,972 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.20 Median:65.50 stddev:11.75 (17.9%) stddev-sans-first:12.25 13:08:16 INFO - 2015-11-23 13:08:16,972 DEBUG : BROWSER_OUTPUT: Values: 65.0 64.0 65.0 65.0 65.0 64.0 66.0 72.0 91.0 95.0 13:08:16 INFO - 2015-11-23 13:08:16,972 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:08:16 INFO - 2015-11-23 13:08:16,972 DEBUG : BROWSER_OUTPUT: 13:08:17 INFO - 2015-11-23 13:08:17,564 INFO : Browser exited with error code: 0 13:08:17 INFO - 2015-11-23 13:08:17,606 INFO : Completed test kraken (00:00:55) 13:08:17 INFO - 2015-11-23 13:08:17,607 INFO : Starting test v8_7 13:08:17 INFO - 2015-11-23 13:08:17,607 DEBUG : operating with platform_type : mac_ 13:08:17 INFO - 2015-11-23 13:08:17,607 INFO : Initialising browser for v8_7 test... 13:08:17 INFO - 2015-11-23 13:08:17,618 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/tmpigiZk3/profile http://localhost:53187/getInfo.html 13:08:19 INFO - 2015-11-23 13:08:19,568 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:08:19 INFO - 2015-11-23 13:08:19,568 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:08:19 INFO - 2015-11-23 13:08:19,568 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 13:08:19 INFO - 2015-11-23 13:08:19,568 DEBUG : BROWSER_OUTPUT: __metrics 13:08:19 INFO - 2015-11-23 13:08:19,576 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:08:19 INFO - 2015-11-23 13:08:19,825 DEBUG : BROWSER_OUTPUT: console.error: 13:08:19 INFO - 2015-11-23 13:08:19,825 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 13:08:19 INFO - 2015-11-23 13:08:19,825 DEBUG : BROWSER_OUTPUT: Stack: 13:08:19 INFO - 2015-11-23 13:08:19,825 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 13:08:19 INFO - 2015-11-23 13:08:19,825 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 13:08:19 INFO - 2015-11-23 13:08:19,825 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 13:08:19 INFO - 2015-11-23 13:08:19,827 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 13:08:19 INFO - 2015-11-23 13:08:19,827 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 13:08:19 INFO - 2015-11-23 13:08:19,827 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 13:08:19 INFO - 2015-11-23 13:08:19,827 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 13:08:19 INFO - 2015-11-23 13:08:19,827 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 13:08:19 INFO - 2015-11-23 13:08:19,827 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 13:08:19 INFO - 2015-11-23 13:08:19,827 DEBUG : BROWSER_OUTPUT: 13:08:20 INFO - 2015-11-23 13:08:20,214 INFO : Browser initialized. 13:08:20 INFO - 2015-11-23 13:08:20,214 INFO : Running cycle 1/1 for v8_7 test... 13:08:20 INFO - 2015-11-23 13:08:20,215 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/tmpigiZk3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:08:32 INFO - 2015-11-23 13:08:32,117 DEBUG : BROWSER_OUTPUT: RSS: Main: 224079872 13:08:32 INFO - 2015-11-23 13:08:32,117 DEBUG : BROWSER_OUTPUT: 13:08:53 INFO - 2015-11-23 13:08:53,621 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53187/tests/v8_7/run.html (next: http://localhost:53187/tests/v8_7/run.html) 13:08:53 INFO - 2015-11-23 13:08:53,878 DEBUG : BROWSER_OUTPUT: RSS: Main: 719962112 13:08:53 INFO - 2015-11-23 13:08:53,878 DEBUG : BROWSER_OUTPUT: 13:08:53 INFO - 2015-11-23 13:08:53,879 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:08:53 INFO - 2015-11-23 13:08:53,879 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:08:53 INFO - 2015-11-23 13:08:53,879 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:08:53 INFO - 2015-11-23 13:08:53,879 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:08:53 INFO - 2015-11-23 13:08:53,879 DEBUG : BROWSER_OUTPUT: |0;Richards;148.5222040695084 13:08:53 INFO - 2015-11-23 13:08:53,879 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;161.05653084232566 13:08:53 INFO - 2015-11-23 13:08:53,879 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.74115665356544 13:08:53 INFO - 2015-11-23 13:08:53,879 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4761.9047619047615 13:08:53 INFO - 2015-11-23 13:08:53,879 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1702.3809523809523 13:08:53 INFO - 2015-11-23 13:08:53,879 DEBUG : BROWSER_OUTPUT: |5;Earley;789.2659826361484 13:08:53 INFO - 2015-11-23 13:08:53,879 DEBUG : BROWSER_OUTPUT: |6;Boyer;13012.987012987012 13:08:53 INFO - 2015-11-23 13:08:53,879 DEBUG : BROWSER_OUTPUT: |7;RegExp;26947.36842105263 13:08:53 INFO - 2015-11-23 13:08:53,879 DEBUG : BROWSER_OUTPUT: |8;Splay;753.3234859675036 13:08:53 INFO - 2015-11-23 13:08:53,879 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4509.009009009009 13:08:53 INFO - 2015-11-23 13:08:53,880 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:08:53 INFO - 2015-11-23 13:08:53,880 DEBUG : BROWSER_OUTPUT: __startTimestamp1448312933872__endTimestamp 13:08:53 INFO - 2015-11-23 13:08:53,880 DEBUG : BROWSER_OUTPUT: 13:08:53 INFO - 2015-11-23 13:08:53,880 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:08:53 INFO - 2015-11-23 13:08:53,880 DEBUG : BROWSER_OUTPUT: Number of tests: 10 13:08:53 INFO - 2015-11-23 13:08:53,880 DEBUG : BROWSER_OUTPUT: 13:08:53 INFO - 2015-11-23 13:08:53,880 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:148.52 Median:148.52 stddev:0.00 (0.0%) 13:08:53 INFO - 2015-11-23 13:08:53,880 DEBUG : BROWSER_OUTPUT: Values: 148.5 13:08:53 INFO - 2015-11-23 13:08:53,880 DEBUG : BROWSER_OUTPUT: 13:08:53 INFO - 2015-11-23 13:08:53,880 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:161.06 Median:161.06 stddev:0.00 (0.0%) 13:08:53 INFO - 2015-11-23 13:08:53,880 DEBUG : BROWSER_OUTPUT: Values: 161.1 13:08:53 INFO - 2015-11-23 13:08:53,880 DEBUG : BROWSER_OUTPUT: 13:08:53 INFO - 2015-11-23 13:08:53,880 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.74 Median:280.74 stddev:0.00 (0.0%) 13:08:53 INFO - 2015-11-23 13:08:53,880 DEBUG : BROWSER_OUTPUT: Values: 280.7 13:08:53 INFO - 2015-11-23 13:08:53,881 DEBUG : BROWSER_OUTPUT: 13:08:53 INFO - 2015-11-23 13:08:53,881 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4761.90 Median:4761.90 stddev:0.00 (0.0%) 13:08:53 INFO - 2015-11-23 13:08:53,881 DEBUG : BROWSER_OUTPUT: Values: 4761.9 13:08:53 INFO - 2015-11-23 13:08:53,881 DEBUG : BROWSER_OUTPUT: 13:08:53 INFO - 2015-11-23 13:08:53,881 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1702.38 Median:1702.38 stddev:0.00 (0.0%) 13:08:53 INFO - 2015-11-23 13:08:53,881 DEBUG : BROWSER_OUTPUT: Values: 1702.4 13:08:53 INFO - 2015-11-23 13:08:53,881 DEBUG : BROWSER_OUTPUT: 13:08:53 INFO - 2015-11-23 13:08:53,881 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:789.27 Median:789.27 stddev:0.00 (0.0%) 13:08:53 INFO - 2015-11-23 13:08:53,881 DEBUG : BROWSER_OUTPUT: Values: 789.3 13:08:53 INFO - 2015-11-23 13:08:53,881 DEBUG : BROWSER_OUTPUT: 13:08:53 INFO - 2015-11-23 13:08:53,881 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:13012.99 Median:13012.99 stddev:0.00 (0.0%) 13:08:53 INFO - 2015-11-23 13:08:53,881 DEBUG : BROWSER_OUTPUT: Values: 13013.0 13:08:53 INFO - 2015-11-23 13:08:53,881 DEBUG : BROWSER_OUTPUT: 13:08:53 INFO - 2015-11-23 13:08:53,881 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26947.37 Median:26947.37 stddev:0.00 (0.0%) 13:08:53 INFO - 2015-11-23 13:08:53,882 DEBUG : BROWSER_OUTPUT: Values: 26947.4 13:08:53 INFO - 2015-11-23 13:08:53,882 DEBUG : BROWSER_OUTPUT: 13:08:53 INFO - 2015-11-23 13:08:53,882 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:753.32 Median:753.32 stddev:0.00 (0.0%) 13:08:53 INFO - 2015-11-23 13:08:53,882 DEBUG : BROWSER_OUTPUT: Values: 753.3 13:08:53 INFO - 2015-11-23 13:08:53,882 DEBUG : BROWSER_OUTPUT: 13:08:53 INFO - 2015-11-23 13:08:53,882 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4509.01 Median:4509.01 stddev:0.00 (0.0%) 13:08:53 INFO - 2015-11-23 13:08:53,882 DEBUG : BROWSER_OUTPUT: Values: 4509.0 13:08:53 INFO - 2015-11-23 13:08:53,882 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:08:53 INFO - 2015-11-23 13:08:53,882 DEBUG : BROWSER_OUTPUT: 13:08:54 INFO - 2015-11-23 13:08:54,513 INFO : Browser exited with error code: 0 13:08:54 INFO - 2015-11-23 13:08:54,530 INFO : Completed test v8_7 (00:00:36) 13:08:54 INFO - 2015-11-23 13:08:54,877 INFO : Completed test suite (00:20:07) 13:08:54 INFO - 2015-11-23 13:08:54,877 DEBUG : Working with test: dromaeo_css 13:08:54 INFO - 2015-11-23 13:08:54,878 DEBUG : Generating results file: dromaeo_css 13:08:54 INFO - 2015-11-23 13:08:54,878 DEBUG : Working with test: kraken 13:08:54 INFO - 2015-11-23 13:08:54,878 DEBUG : Generating results file: kraken 13:08:54 INFO - 2015-11-23 13:08:54,879 INFO : javascript benchmark 13:08:54 INFO - 2015-11-23 13:08:54,879 DEBUG : Working with test: v8_7 13:08:54 INFO - 2015-11-23 13:08:54,879 DEBUG : Generating results file: v8_7 13:08:54 INFO - 2015-11-23 13:08:54,879 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:08:55 INFO - 2015-11-23 13:08:55,277 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 13:08:55 INFO - 2015-11-23 13:08:55,277 DEBUG : process_Request line: dromaeo_css 7681.14 graph.html#tests=[[72,64,59]] 13:08:55 INFO - 2015-11-23 13:08:55,277 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:08:55 INFO - 2015-11-23 13:08:55,304 DEBUG : process_Request line: kraken 1397.60 graph.html#tests=[[232,64,59]] 13:08:55 INFO - 2015-11-23 13:08:55,304 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:08:55 INFO - 2015-11-23 13:08:55,327 DEBUG : process_Request line: v8_7 20350.95 graph.html#tests=[[230,64,59]] 13:08:55 INFO - 2015-11-23 13:08:55,328 INFO : javascript benchmark 13:08:55 INFO - 2015-11-23 13:08:55,330 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3368.107451525346, 3480.8781692640764, 3518.4018716818136, 3520.06718219672, 3541.433370660694, 5711.8000869969555, 5853.531717462603, 5980.940190598093, 5982.551308651852, 5995.880082398349, 5812.912806307909, 5859.091840764689, 5876.706164691759, 5877.764889404419, 5899.233099697044, 5282.286891269678, 5313.814016509404, 5364.409914909357, 5364.678119312854, 5396.946030539703, 5397.217403476494, 5405.27028851104, 5405.37838148614, 5413.106837371829, 5418.349798024243, 4639.257718764999, 4783.641226907978, 5116.462771408986, 5396.244525766396, 5409.29679141711, 5389.946100539003, 5405.00007498612, 5405.486478784509, 5409.080456322396, 5409.945900541023, 4602.6422205449135, 5056.443791182967, 5170.560502357304, 5254.737263136828, 5350.866228344284, 5961.552883533753, 6069.817905462844, 6077.0, 6088.96955515224, 6090.786822461193, 6243.500519958392, 6285.717142728588, 6312.621242725405, 6314.242290925118, 6339.302676705559, 6162.075688646694, 6217.347178546278, 6261.530385221126, 6267.373262673742, 6330.778422755181, 5239.502247286502, 6075.210222671025, 6081.574289799716, 6115.4801841843055, 6115.48018418435, 6498.090267362573, 6499.707513161825, 6500.0, 6509.0, 6515.413612774778, 6110.777844431132, 6172.321044685081, 6233.438990490878, 6238.033104868752, 6307.621542707452, 6336.144620476177, 6357.777477788255, 6361.681915904186, 6373.139626150503, 6379.234491861006, 6228.34602366754, 6290.0, 6304.432601065926, 6306.180196574508, 6320.494360451153, 5954.583179177503, 6165.075238714139, 6167.907481387782, 6231.4391704746795, 6290.119383286344, 5065.366829146356, 5083.339165908482, 5086.135356989321, 5093.847184584469, 5131.409887862869, 4521.276595744731, 4522.909541809146, 4528.88677783058, 4540.841070562515, 4542.772861356919, 5770.682612456271, 5883.323417807007, 5904.350521442638, 5905.0, 6002.09968504719, 6344.936550634527, 6418.1656384669695, 6422.8715425691225, 6430.903536446957, 6433.581817181962, 6030.969845150834, 6045.153678485016, 6080.7871724490315, 6085.421884920926, 6092.969535152296, 5403.891922161613, 5427.48438898304, 5499.890002199933, 5504.422035686275, 5610.158476228598, 6311.936880631227, 6350.301466838551, 6351.2060992375955, 6364.331745166876, 6481.805545833632, 6372.36276372359, 6372.36276372359, 6379.170707807955, 6383.776567820104, 6397.936020639734, 6519.511036672364, 6539.901901471387, 6550.803475895731, 6563.982582699689, 6580.1116849224745, 5579.804706835242, 6187.3503282154725, 6251.624902505682, 6316.273628532594, 6324.841878953063, 6224.0, 6359.936400636119, 6368.203974503187, 6388.68056597159, 6392.296847346881, 5155.819546315861, 6314.905276420765, 6333.2716737575765, 6356.4279214870885, 6367.299597044229, 5620.594851287178, 5877.823665290048, 6117.143599896107, 6154.292256390393, 6309.463695585927, 6096.266235377076, 6098.361960870079, 6108.251008765869, 6109.991851344478, 6130.01919692847, 6308.306086330592, 6328.493720502257, 6337.397947195009, 6338.049292606146, 6361.459275961595, 5962.642241465526, 6053.788117415869, 6073.149759033827, 6118.938810611837, 6178.474829639531], "unit": "ms", "name": "dojo.html", "value": 5823.0967311093855}, {"lowerIsBetter": false, "replicates": [552.1827695011385, 562.1371195215345, 581.9931518473039, 582.7581553655233, 601.4827248566232, 32343.191420214476, 32734.67265327349, 40837.59162408379, 41385.172296554054, 41414.58585414152, 44064.77967610158, 44441.0, 44600.553994460046, 44614.55385446153, 44656.55343446573, 8617.009043959963, 9657.17913977311, 9845.36005159666, 9845.950770246138, 9855.605775768961, 8803.911960880405, 8890.421777684463, 9711.174550163245, 11861.822072668916, 11876.703082422922, 11655.708607284843, 11726.0, 11736.882631173707, 11746.0, 11752.7649447011, 8919.286457083417, 9014.233790127848, 11704.239224450426, 11744.706382340424, 11772.529098836036, 8783.516906570136, 11675.12436567261, 11812.0, 11819.054475641928, 11824.52701891932, 41093.38359924604, 41399.0, 41475.75572732823, 41478.96302592429, 41479.963000924916, 3230.8223047732367, 3369.2587630721446, 3377.5440315557576, 3848.8460461581503, 3897.824597893073, 23444.600532922803, 28974.13077607654, 29452.96914608, 29508.852455737582, 29518.40963180746, 2786.3730660601404, 2826.2651710555406, 2872.755815755663, 2926.502494575906, 2979.2998645318335, 465797.0, 466219.0, 467224.0, 467712.0, 467882.0, 57724.0, 58368.0, 58658.41341586615, 67874.0, 68552.0, 68971.65514172497, 69164.3083569168, 69957.0, 70027.64986175037, 70175.64912175406, 16540.421085261958, 16730.581735456468, 16761.580960476087, 16773.0, 16774.580635483966, 12685.492580296685, 12718.745625087631, 12753.617391478085, 12771.425285862158, 12975.0, 15384.692306153815, 16817.747733784003, 20616.896915515626, 20652.0, 21154.471138221666, 7823.374130069581, 8671.956640216758, 8676.392652514389, 8928.419652722552, 8930.776730581787, 965.9661911833052, 998.7902540466583, 1046.3564907581783, 1084.4848696868924, 1091.770728147098, 29558.556621650692, 30744.231394215323, 31116.68883311138, 31583.52624710631, 31857.0, 1003.3177439341318, 1029.5469993202967, 1073.1682945717132, 1074.5755426606604, 1125.7016890524017, 14877.553673389815, 14931.850681493046, 15025.417247739544, 15045.473408430653, 15101.622459438602, 549978.0, 551867.9252829842, 552997.0, 553961.0, 555855.0, 45737.0, 58617.0, 58670.70664646735, 58715.53211169755, 58797.0, 1457.8104846370115, 1461.335092532895, 1479.2603698150924, 1491.5450787509697, 1493.865552100316, 29348.11955641334, 30023.399532009673, 30276.54585181268, 30374.392512149192, 30740.846295769272, 50199.74900125622, 51220.71948201325, 54129.18806217831, 54538.181927271915, 54565.72717136389, 389059.0, 527302.0, 532708.0, 534419.0, 535266.7969863109, 30780.84609576938, 31141.065768026994, 31144.0, 31149.844250778602, 31188.0, 43201.35197972096, 43769.90575235645, 43789.56210437855, 44335.0, 45014.77492612516, 36730.26539469249, 36918.630813692595, 37349.62650373462, 38686.419703703905, 39344.0, 36746.448803267434, 37003.62996370002, 37937.43093853539, 38094.428583571826, 38181.42727859029, 36954.63045369512, 37711.49154033808, 38014.0, 38039.42940855834, 38073.42889856599, 31998.68001319957, 33377.165570860925, 33654.0, 33772.32455350929, 33902.81340153083, 24973.375665608506, 25044.62433063469, 25175.74824251807, 25629.615555766304, 25660.358491037874], "unit": "ms", "name": "ext.html", "value": 20355.195664845727}, {"lowerIsBetter": false, "replicates": [335.2273010710313, 346.4456869009583, 360.4575114452748, 370.5386793442165, 375.0847931048242, 16712.41506547271, 17864.28542858284, 20120.0, 20700.378988630346, 21416.89291553542, 21870.0, 21903.233386831464, 22434.88782556085, 22440.32679019632, 22440.887795561, 6426.485881129498, 6580.243272023707, 6591.703373348211, 6593.20881494219, 6603.372679595454, 3894.532656081274, 4039.8788036358956, 4044.373122166069, 5800.9129863052085, 6597.274299827015, 5936.5547583931375, 5938.435848594377, 5952.136940143677, 5960.374160713128, 5966.284045914496, 6148.907766383508, 6464.353564643545, 6466.838329041764, 6472.158619379497, 6480.088373929679, 5409.918851217196, 5681.659100453986, 5691.573132015074, 5694.259746233005, 5720.0, 12833.165844220095, 12849.486020559167, 12995.870041299655, 13019.414126364336, 13059.869401306056, 2163.6862654915108, 2199.065397206181, 2209.591225623265, 2214.745304290011, 2242.6972358731687, 9946.154576860976, 10082.69751907444, 10391.480425978747, 11938.343391113485, 14550.708985820223, 1699.065513967313, 1706.9487915362558, 1738.2612389734313, 1771.070188151231, 1805.3500739733686, 99172.0, 102960.97039029664, 103663.0, 104448.0, 105810.0, 11122.165837562216, 11123.555057797597, 11129.332240065622, 11132.49903754333, 11242.7189320266, 13235.735285294433, 13318.467261309439, 13344.532941347006, 13346.799798003038, 13358.332083395791, 7444.925550744531, 7810.0, 7865.820126980999, 8571.442856214326, 8581.0, 8374.2881855043, 8752.56237188138, 8765.693200737944, 8840.204381605558, 8856.335774816915, 4272.957270427318, 4319.568043195655, 4333.783310834446, 4360.956390436118, 4389.517153113155, 1424.672325365151, 1693.8306169382963, 1766.2493440288083, 1766.8586513078924, 1769.6991511443086, 920.3741455810114, 949.2168960607527, 980.7940332530106, 989.4459102902398, 1004.7488127968008, 19648.70526942097, 19829.0, 20282.0, 20700.171993120406, 21150.83670398143, 839.5214727605206, 913.6436789652041, 917.3899356927702, 981.3081777346953, 986.5461887531673, 10362.689119326282, 10681.438231404516, 10685.358878467317, 10702.357858528514, 10740.677779666623, 778019.0, 785493.3781290768, 789088.0, 792759.0362048153, 795039.0, 126767.0, 129707.0, 132714.0, 133232.00151997534, 133895.3305233487, 1170.151640060966, 1171.7305019845312, 1244.1788419643174, 1247.108317552954, 1289.3939848271298, 16379.836201638307, 18053.819461805215, 18734.25062997465, 18871.90564047171, 18961.0, 44132.11735765331, 45633.543664564255, 49825.00349992907, 50924.0, 51046.0, 63481.047784284194, 64288.678556606916, 64624.353756463715, 65858.67070664807, 66153.35386584482, 4315.676324275754, 9485.762855928657, 9642.878566715312, 9921.55353009102, 9948.204143668634, 11936.701582460508, 12047.698807529532, 16612.83387166113, 21333.146674132862, 21336.826474543428, 16009.919950400174, 16092.0, 16235.918820405823, 16467.01197928128, 16613.667726645643, 15566.766498502306, 15915.0, 16152.192390380198, 16201.837981620505, 16775.832241677916, 11310.830337545109, 13235.66910827237, 13253.66865828362, 16815.327386904388, 17123.22945467432, 9517.048295170427, 9667.226621870373, 9694.660686875926, 9729.70810875675, 9784.266180036384, 10111.191104711752, 10212.08091271789, 13706.451741930212, 15762.054276743433, 16248.91875540662], "unit": "ms", "name": "jquery.html", "value": 9788.13528676238}, {"lowerIsBetter": false, "replicates": [1646.3003223629958, 1658.6019355354715, 1671.5069054628884, 1940.8932508712014, 1979.079727926514, 7253.347198752112, 7590.810229744259, 8304.584770761468, 8391.832163356745, 8432.704855330065, 6572.507061970347, 8237.299829514484, 8239.876401853962, 8309.875351869727, 8313.293370063537, 2087.728595282611, 2131.6482780341225, 2361.1499860050367, 2378.666986621866, 2389.259329607827, 2159.4817243861517, 2164.956700865982, 2171.0881429799524, 2356.905723771047, 2387.319613910036, 2320.477892474197, 2355.0815182079004, 2355.6702061711376, 2361.244401791427, 2363.52729454109, 2346.272655476808, 2379.7977171940406, 2382.094803974487, 2392.605220138675, 2394.1381102802975, 2133.765285818559, 2172.8261739060836, 2175.423512769117, 2356.4815740537056, 2398.8080953523677, 8189.7133600323705, 8322.375821813388, 8322.542260175687, 8325.750227493185, 8328.50028998256, 5202.7918883245, 5248.265242866002, 5277.656952298127, 5294.047071527124, 5298.655587386807, 3393.4570468724887, 3403.3533628610485, 3450.2064525159103, 3592.209713862946, 3599.3881040223223, 1004.0311099788739, 1030.5311083457009, 1031.3502493429166, 1037.6316407675242, 1046.785408991155, 10627.14982801374, 10887.891121088845, 10935.671929842118, 10963.232573719843, 10968.067714244298, 4459.509453960061, 4499.167653984024, 4561.749103799323, 4580.564846339593, 4590.747508886977, 9065.365424420228, 9096.54517274147, 9106.952700439402, 9110.225630821455, 9112.088791120967, 5165.48345165488, 5188.299579556787, 5196.480351964773, 5202.895942081137, 5206.5314121729225, 4787.976060119677, 4811.518848115161, 4819.831305904347, 4832.033593281358, 4833.3958255218095, 3093.443180227536, 3547.2550764339776, 3607.152319204985, 3634.6183650716293, 3676.926461470809, 1112.844201811747, 1131.7340425000118, 1138.9544418223345, 1139.88601139887, 1141.1840534018052, 1339.8794108530278, 1343.623785340087, 1355.0650051464459, 1384.8684374984562, 1405.5994041698068, 7931.405144614177, 7936.563489008045, 7967.04395472547, 7970.880436793453, 7981.281684648294, 496.9403671559436, 501.79928028788777, 503.0542579949744, 507.9492050794965, 509.9796008159706, 5693.089105743061, 6073.544484163705, 6182.041783523561, 6247.032184861754, 6269.968650156811, 9517.666881659108, 9570.234381249484, 9702.0, 9751.878533968542, 9753.0, 9517.904820951702, 9595.13643772064, 9637.132658060807, 9827.606895724233, 9902.158316543031, 7726.188750181263, 7859.0, 7865.292123708779, 7878.606069696492, 7938.880916786253, 7789.1821358756515, 7828.138904720362, 7829.491083079582, 7888.290053895177, 7892.36861051103, 7438.851222975402, 8978.820423591622, 9016.233620142099, 9091.818163636823, 9156.816863662556, 7362.3741981932135, 9178.036306187754, 9365.11031452011, 9517.571709273238, 9531.523423828643, 7260.600666963368, 7307.890381644173, 7308.634568271672, 7427.4800763946005, 7442.7395041173295, 7943.602819859099, 8002.759917202493, 8011.759647210593, 8019.679212831421, 8020.799480013046, 6084.726187321669, 7278.526895751759, 7387.224341444071, 7521.5111017783665, 7640.579768112807, 7260.0, 7260.4554658399775, 7319.414446844133, 7394.371478424179, 7415.369693576106, 7375.409967202503, 7413.073365829271, 7443.888341674771, 7469.290417410337, 7509.0, 5901.704914754331, 6789.0, 6838.042674025541, 6853.828654283483, 6871.381575658214, 6776.559523630948, 6802.0477133202385, 6825.488088393291, 6872.725090996504, 6883.7590684325805], "unit": "ms", "name": "mootools.html", "value": 4613.952216472183}, {"lowerIsBetter": false, "replicates": [324.1183979575555, 326.9542264083029, 333.7780376049927, 334.20459306849693, 339.1893374834147, 6894.655267236643, 6896.689648965802, 6898.1377327834025, 6909.101816763826, 6929.445644348452, 5529.281193444856, 6876.724931002754, 6877.002834588981, 6899.793006209809, 6912.101426814507, 4924.138275801738, 5023.874403139924, 5036.974815125937, 5060.06388818068, 5062.291279220912, 5031.471695471978, 5042.268871013701, 5067.0, 5084.3644544431945, 5105.566026887719, 5023.397192336906, 5031.11955407804, 5043.193089105744, 5055.064813009605, 5057.468965758598, 4826.34844296019, 4961.082199793013, 4967.081089998362, 4981.37732783402, 5047.899042019158, 4324.589164029412, 4342.023044814923, 4348.152110338485, 4361.389405483234, 4363.367311739812, 6605.339466053404, 6618.040384144272, 6618.503612229054, 6618.536702430832, 6656.733730650768, 5518.227448157261, 5533.806316778893, 5714.285714285715, 5931.555133365015, 5932.525397968152, 7386.187519372865, 7404.0, 7405.333519983174, 7408.222136675679, 7423.962880185564, 4877.122118018755, 4881.6338774591695, 4883.731394773286, 4885.7312847793355, 4897.485763994765, 7568.4323675724545, 7858.607069646495, 7877.6848926042885, 7890.447668663196, 7897.407694422941, 4975.0, 4978.8257410990445, 4984.2025275955675, 4985.376827896513, 4993.525615066563, 5034.144195486776, 5066.164082926276, 5066.581357219984, 5074.264231686385, 5086.516780905808, 5800.767969281266, 6013.849653758603, 6015.729292181775, 6016.608920420159, 6021.976264035125, 6026.306974697965, 7369.852602948018, 7429.0, 7446.0, 7447.441441891771, 1738.965220695579, 1762.903040332794, 1763.8765286430084, 1764.673535395956, 1769.0, 998.6953979036318, 1007.6976906927893, 1037.9931466477506, 1126.5831642292405, 1136.0286954653652, 6449.226092868792, 7032.331928466788, 7058.647067646597, 7061.6469176542, 7081.468889833283, 7693.307602315706, 7696.961515192388, 7710.151883292833, 7712.5758083305955, 7726.7681969541, 6853.211880633691, 7022.719091236396, 7036.718531258693, 7043.436525077981, 7086.00795888576, 3768.6042965488227, 4074.796260186979, 4094.713370064067, 4095.1400205957084, 4102.589741025873, 6449.129367535416, 7510.399168066541, 8034.879476807852, 8037.477563958324, 8049.993750781152, 7221.73619616565, 7348.889766653505, 7545.471816972759, 7836.059672839182, 7960.641771120314, 6708.932910670928, 7230.493865429475, 8083.353331733447, 8084.312833409226, 8108.472949258279, 7726.652300646372, 7730.072391313079, 7738.92261077382, 7738.961305193438, 7745.806354841174, 7346.77959661211, 7597.0, 7603.467757256939, 7610.771676849703, 7611.162772095176, 8051.758447246592, 8062.879056814035, 8066.23370779775, 8070.919290807017, 8075.5558444286125, 4765.8093676252565, 4940.481249468754, 4941.43173535048, 4951.777170027285, 4953.430355509163, 6218.471429928507, 7697.730579429693, 7698.384129269533, 7701.152873183833, 7740.92259077402, 7390.334869861738, 7409.962950185214, 7411.4070874331, 7415.5179913305465, 7423.517471364344, 7194.820129496805, 7392.556446613005, 7395.0, 7452.21751716062, 7486.588237646763, 7269.164046134762, 7277.672504737406, 7283.417326613964, 7286.089238845145, 7310.707571697072, 7264.709411623476, 7477.401807855467, 7484.0, 7490.550566966, 7495.138059123271, 7311.195768465571, 7323.2676732326345, 7327.816804579928, 7330.743423980135, 7343.816404589928], "unit": "ms", "name": "prototype.html", "value": 5395.432711028086}, {"lowerIsBetter": false, "replicates": [709.8473828126952, 713.5362014690451, 746.4401698725956, 776.103600341605, 785.1441928298156, 18379.816201837977, 18635.068246587685, 18678.719819202724, 18698.15858286377, 18758.34345797899, 16716.0, 16803.0, 16828.990260584374, 16846.410375636857, 16915.1542422879, 778.1090651204368, 786.0685088170536, 787.9606019699021, 789.7907054630527, 924.6024209589874, 956.2636769687336, 961.9326647134703, 975.2539307429822, 977.5014742481314, 978.2565250409705, 1017.694691592523, 1020.9438480883548, 1022.4427686910615, 1022.6318525330912, 1023.2274632652337, 798.0981490915258, 809.3242142810731, 809.8623234050167, 811.7686459359113, 1014.90865822076, 745.3589912675095, 763.1224092293851, 763.9465237433382, 765.1697907770076, 765.4641750774424, 15581.688366232613, 15702.0, 15774.842251577453, 15785.68428631421, 15798.0, 12587.559435419807, 12918.22490650564, 12925.224486530838, 13076.607701768962, 13104.934475327562, 10091.444970526618, 10226.181905447545, 10353.637622683245, 10379.221558383077, 11141.610043648514, 3544.6455354464347, 3598.5321908152036, 3599.2621512590117, 3612.1692010837655, 3613.7470377073614, 75934.62032689857, 78163.0, 79812.40375192522, 81817.18182818155, 85231.5738421304, 7969.641366138421, 9879.357841740264, 9881.0, 9908.603655853829, 10037.096661300518, 18977.620447590973, 22883.31350059501, 23064.308070757903, 23098.0, 23130.53738925212, 7580.620968951531, 7723.459357845009, 7905.881411778828, 8010.198980101944, 8020.839583208303, 4114.259433301974, 4133.731307465006, 4191.161767646483, 4245.172191422643, 4268.679849011337, 3537.699295559855, 3580.480830279595, 3585.5697316321684, 3589.9282014359565, 3593.2813437312643, 595.3213336796056, 601.9187409699634, 632.6836581709146, 648.5881465269588, 657.7763560389491, 476.95945844603597, 497.572088004316, 501.5486062543667, 529.1348644965509, 587.9735411906474, 6741.460683145337, 8708.390412671179, 8722.520261385685, 8849.115088491228, 8947.418417802952, 510.81745758569537, 543.9048166570834, 577.4918072096613, 603.7403916315939, 625.7528276330914, 3918.7256892017285, 4029.5164580250557, 4050.311447054008, 4138.399932009842, 4165.8958526037095, 104417.0, 106429.0, 107402.0, 107511.46244268885, 107994.0, 80570.0, 82053.0, 83521.16478835256, 84457.0, 86156.13843861606, 73589.63205183939, 74106.6294668534, 74154.99999999892, 74633.25366746372, 75853.24146758571, 8907.821843563223, 8921.553922303989, 9084.727458176265, 9200.861987070333, 9277.721668349961, 42120.157596848505, 51116.0, 51178.74410627923, 55639.165412518036, 55763.0, 59687.0, 60934.69532652486, 62295.37704623077, 63048.68475657592, 63216.36783632105, 9219.202255560102, 9767.755806104904, 10607.461918021998, 11538.019268361948, 11966.581169659368, 11948.581799636971, 12189.817152742893, 12226.388680566113, 12251.69370765738, 12257.754844902873, 11555.0, 11672.70818229551, 11683.941580292045, 11684.591039313584, 11707.590234341757, 11562.190646654653, 11662.70843228926, 11732.765344692887, 11745.588904388647, 11747.647570572897, 11376.203665743318, 11420.257683250562, 11489.195756297313, 11496.82754758696, 11508.53965841357, 9776.21790256792, 10253.743656408351, 10292.845607316047, 10298.536565854705, 10304.227182961458, 9797.167240784613, 9931.503424828585, 10051.798964020825, 10112.0, 10126.898731012596], "unit": "ms", "name": "yui.html", "value": 7110.290942458372}], "name": "dromaeo_css", "value": 7681.136001014052}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 109.0, 104.0, 109.0, 109.0, 110.0, 100.0, 111.0, 111.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 108.1}, {"lowerIsBetter": true, "replicates": [152.0, 120.0, 144.0, 156.0, 114.0, 142.0, 167.0, 145.0, 186.0, 116.0], "unit": "ms", "name": "audio-beat-detection", "value": 144.2}, {"lowerIsBetter": true, "replicates": [183.0, 181.0, 177.0, 185.0, 184.0, 185.0, 183.0, 186.0, 186.0, 180.0], "unit": "ms", "name": "audio-dft", "value": 183.0}, {"lowerIsBetter": true, "replicates": [80.0, 65.0, 75.0, 74.0, 56.0, 57.0, 57.0, 70.0, 74.0, 54.0], "unit": "ms", "name": "audio-fft", "value": 66.2}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 119.0, 74.0, 75.0, 74.0, 114.0, 74.0, 73.0, 113.0], "unit": "ms", "name": "audio-oscillator", "value": 88.3}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 86.0, 86.0, 86.0, 86.0, 86.0, 86.0, 85.0, 86.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 85.8}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 92.0, 94.0, 94.0, 93.0, 93.0, 93.0, 93.0, 93.0], "unit": "ms", "name": "imaging-darkroom", "value": 93.3}, {"lowerIsBetter": true, "replicates": [93.0, 142.0, 127.0, 87.0, 84.0, 84.0, 85.0, 87.0, 85.0, 88.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [57.0, 55.0, 55.0, 54.0, 55.0, 54.0, 54.0, 65.0, 54.0, 54.0], "unit": "ms", "name": "json-parse-financial", "value": 55.7}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 64.0, 64.0, 65.0, 66.0, 66.0, 68.0, 69.0, 67.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 65.8}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 82.0, 83.0, 83.0, 83.0, 83.0, 82.0, 101.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.5}, {"lowerIsBetter": true, "replicates": [118.0, 130.0, 124.0, 103.0, 118.0, 123.0, 119.0, 113.0, 165.0, 124.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 123.7}, {"lowerIsBetter": true, "replicates": [133.0, 126.0, 136.0, 135.0, 135.0, 122.0, 135.0, 135.0, 135.0, 124.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 131.6}, {"lowerIsBetter": true, "replicates": [65.0, 64.0, 65.0, 65.0, 65.0, 64.0, 66.0, 72.0, 91.0, 95.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 71.2}], "name": "kraken", "value": 1397.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [148.5222040695084], "unit": "score", "name": "Richards", "value": 237.68836600000003}, {"lowerIsBetter": false, "replicates": [161.05653084232566], "unit": "score", "name": "DeltaBlue", "value": 410.52666200000004}, {"lowerIsBetter": false, "replicates": [280.74115665356544], "unit": "score", "name": "Encrypt", "value": 948.136722}, {"lowerIsBetter": false, "replicates": [4761.9047619047615], "unit": "score", "name": "Decrypt", "value": 55.89801000000001}, {"lowerIsBetter": false, "replicates": [1702.3809523809523], "unit": "score", "name": "RayTrace", "value": 434.6788531468532}, {"lowerIsBetter": false, "replicates": [789.2659826361484], "unit": "score", "name": "Earley", "value": 844.4086210000003}, {"lowerIsBetter": false, "replicates": [13012.987012987012], "unit": "score", "name": "Boyer", "value": 51.21522055888228}, {"lowerIsBetter": false, "replicates": [26947.36842105263], "unit": "score", "name": "RegExp", "value": 33.80608398437501}, {"lowerIsBetter": false, "replicates": [753.3234859675036], "unit": "score", "name": "Splay", "value": 108.17530784313725}, {"lowerIsBetter": false, "replicates": [4509.009009009009], "unit": "score", "name": "NavierStokes", "value": 329.11888111888123}], "name": "v8_7", "value": 20350.95205666916}]} 13:08:55 INFO - RETURN: dromaeo_css: 7681.14 13:08:55 INFO - RETURN: kraken: 1397.60 13:08:55 INFO - RETURN: v8_7: 20350.95 13:08:55 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,59]]", "result": "20350.95"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1397.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7681.14"}}} 13:08:55 INFO - Return code: 0 13:08:55 INFO - # TBPL SUCCESS # 13:08:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:08:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:08:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:08:55 INFO - 2015-11-23 13:08:55.406 screenresolution[3241:57631] starting screenresolution argv=screenresolution get 13:08:55 INFO - 2015-11-23 13:08:55.409 screenresolution[3241:57631] Display 0: 1600x1200x32@60 13:08:55 INFO - 2015-11-23 13:08:55.415 screenresolution[3242:57634] starting screenresolution argv=screenresolution list 13:08:55 INFO - Available Modes on Display 0 13:08:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:08:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:08:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:08:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:08:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:08:55 INFO - Intel Iris: 13:08:55 INFO - Chipset Model: Intel Iris 13:08:55 INFO - Type: GPU 13:08:55 INFO - Bus: Built-In 13:08:55 INFO - VRAM (Dynamic, Max): 1536 MB 13:08:55 INFO - Vendor: Intel (0x8086) 13:08:55 INFO - Device ID: 0x0a2e 13:08:55 INFO - Revision ID: 0x0009 13:08:55 INFO - Displays: 13:08:55 INFO - Display: 13:08:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:08:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:08:55 INFO - Display Serial Number: 1600x1200 60 13:08:55 INFO - Main Display: Yes 13:08:55 INFO - Mirror: Off 13:08:55 INFO - Online: Yes 13:08:55 INFO - Rotation: Supported 13:08:55 INFO - Return code: 0 13:08:55 INFO - Running post-action listener: _resource_record_post_action 13:08:55 INFO - Running post-run listener: _resource_record_post_run 13:08:56 INFO - Total resource usage - Wall time: 1239s; CPU: 53.0%; Read bytes: 57344; Write bytes: 688317440; Read time: 2; Write time: 2125 13:08:56 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 338414080; Write bytes: 337520128; Read time: 26090; Write time: 686 13:08:56 INFO - run-tests - Wall time: 1209s; CPU: 53.0%; Read bytes: 57344; Write bytes: 339586560; Read time: 2; Write time: 1408 13:08:56 INFO - Running post-run listener: _upload_blobber_files 13:08:56 INFO - Blob upload gear active. 13:08:56 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 13:08:56 INFO - Copying logs to upload dir... 13:08:56 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1280.096353 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2015-11-23 13:08:56.753315) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 13:08:56.759235) ========= 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.H2RknxGrHl/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.7YEcNZOZDJ/Listeners TMPDIR=/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/MdSlRE8ESpqsXU1pNGJNhw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009553 build_url: 'https://queue.taskcluster.net/v1/task/MdSlRE8ESpqsXU1pNGJNhw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 13:08:56.782981) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 13:08:56.783383) ========= 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.H2RknxGrHl/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.7YEcNZOZDJ/Listeners TMPDIR=/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005371 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 13:08:56.832564) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 13:08:56.832908) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 13:08:56.833358) ========= ========= Total master_lag: 0.21 =========