builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0052 starttime: 1448351549.25 results: success (0) buildid: 20151123230131 builduid: e1a21c9e4fc94800ad47e73ca81a94a6 revision: 4dca10306d58d2e87cbed46a72472b62c17b0ec9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 23:52:29.248728) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 23:52:29.249383) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 23:52:29.249732) ========= 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.C0BS0AOWsI/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.GFVPXWxp90/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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.005606 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 23:52:29.273664) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 23:52:29.274027) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 23:52:29.345603) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 23:52:29.346122) ========= 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.C0BS0AOWsI/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.GFVPXWxp90/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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.005380 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 23:52:29.400197) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 23:52:29.400491) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 23:52:29.400867) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 23:52:29.401184) ========= 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.C0BS0AOWsI/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.GFVPXWxp90/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 23:52:29-- 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% 8.32M=0.001s 2015-11-23 23:52:29 (8.32 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.234909 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 23:52:29.674151) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 23:52:29.674460) ========= 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.C0BS0AOWsI/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.GFVPXWxp90/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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.025265 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 23:52:29.733547) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 23:52:29.733929) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4dca10306d58d2e87cbed46a72472b62c17b0ec9 --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 4dca10306d58d2e87cbed46a72472b62c17b0ec9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.C0BS0AOWsI/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.GFVPXWxp90/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 23:52:29,809 truncating revision to first 12 chars 2015-11-23 23:52:29,809 Setting DEBUG logging. 2015-11-23 23:52:29,809 attempt 1/10 2015-11-23 23:52:29,809 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4dca10306d58?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 23:52:30,625 unpacking tar archive at: fx-team-4dca10306d58/testing/mozharness/ program finished with exit code 0 elapsedTime=1.055616 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 23:52:30.808517) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 23:52:30.809276) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 23:52:30.821901) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 23:52:30.822492) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 23:52:30.823273) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2015-11-23 23:52:30.824592) ========= /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.C0BS0AOWsI/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.GFVPXWxp90/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 23:52:31 INFO - MultiFileLogger online at 20151123 23:52:31 in /builds/slave/test 23:52:31 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 23:52:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:52:31 INFO - {'append_to_log': False, 23:52:31 INFO - 'base_work_dir': '/builds/slave/test', 23:52:31 INFO - 'blob_upload_branch': 'Fx-Team', 23:52:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:52:31 INFO - 'branch': 'Fx-Team', 23:52:31 INFO - 'buildbot_json_path': 'buildprops.json', 23:52:31 INFO - 'config_files': ('talos/mac_config.py',), 23:52:31 INFO - 'default_actions': ('clobber', 23:52:31 INFO - 'read-buildbot-config', 23:52:31 INFO - 'download-and-extract', 23:52:31 INFO - 'populate-webroot', 23:52:31 INFO - 'create-virtualenv', 23:52:31 INFO - 'install', 23:52:31 INFO - 'run-tests'), 23:52:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:52:31 INFO - 'download_minidump_stackwalk': True, 23:52:31 INFO - 'download_symbols': 'ondemand', 23:52:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:52:31 INFO - 'tooltool.py': '/tools/tooltool.py', 23:52:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:52:31 INFO - '/tools/misc-python/virtualenv.py')}, 23:52:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:52:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:52:31 INFO - 'installer_path': 'installer.exe', 23:52:31 INFO - 'log_level': 'info', 23:52:31 INFO - 'log_name': 'talos', 23:52:31 INFO - 'log_to_console': True, 23:52:31 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 23:52:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 23:52:31 INFO - 'opt_config_files': (), 23:52:31 INFO - 'pip_index': False, 23:52:31 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:52:31 INFO - 'cmd': ('bash', 23:52:31 INFO - '-c', 23:52:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:52:31 INFO - 'enabled': True, 23:52:31 INFO - 'halt_on_failure': False, 23:52:31 INFO - 'name': 'check_screen_resolution'},), 23:52:31 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:52:31 INFO - 'cmd': ('bash', 23:52:31 INFO - '-c', 23:52:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:52:31 INFO - 'enabled': True, 23:52:31 INFO - 'halt_on_failure': False, 23:52:31 INFO - 'name': 'check_screen_resolution'},), 23:52:31 INFO - 'run_cmd_checks_enabled': True, 23:52:31 INFO - 'sps_profile': False, 23:52:31 INFO - 'sps_profile_interval': 0, 23:52:31 INFO - 'suite': 'dromaeojs', 23:52:31 INFO - 'system_bits': '64', 23:52:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:52:31 INFO - 'title': 't-yosemite-r7-0052', 23:52:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:52:31 INFO - 'use_talos_json': True, 23:52:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:52:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:52:31 INFO - 'work_dir': 'build'} 23:52:31 INFO - ##### 23:52:31 INFO - ##### Running clobber step. 23:52:31 INFO - ##### 23:52:31 INFO - Running pre-action listener: _resource_record_pre_action 23:52:31 INFO - Running main action method: clobber 23:52:31 INFO - rmtree: /builds/slave/test/build 23:52:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:52:32 INFO - Running post-action listener: _resource_record_post_action 23:52:32 INFO - ##### 23:52:32 INFO - ##### Running read-buildbot-config step. 23:52:32 INFO - ##### 23:52:32 INFO - Running pre-action listener: _resource_record_pre_action 23:52:32 INFO - Running main action method: read_buildbot_config 23:52:32 INFO - Using buildbot properties: 23:52:32 INFO - { 23:52:32 INFO - "properties": { 23:52:32 INFO - "buildnumber": 23, 23:52:32 INFO - "product": "firefox", 23:52:32 INFO - "script_repo_revision": "production", 23:52:32 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 23:52:32 INFO - "repository": "", 23:52:32 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 23:52:32 INFO - "buildid": "20151123230131", 23:52:32 INFO - "slavename": "t-yosemite-r7-0052", 23:52:32 INFO - "pgo_build": "False", 23:52:32 INFO - "basedir": "/builds/slave/test", 23:52:32 INFO - "project": "", 23:52:32 INFO - "platform": "yosemite_r7", 23:52:32 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 23:52:32 INFO - "slavebuilddir": "test", 23:52:32 INFO - "scheduler": "tests-fx-team-macosx64-talos", 23:52:32 INFO - "branch": "fx-team", 23:52:32 INFO - "repo_path": "integration/fx-team", 23:52:32 INFO - "stage_platform": "macosx64", 23:52:32 INFO - "builduid": "e1a21c9e4fc94800ad47e73ca81a94a6", 23:52:32 INFO - "revision": "4dca10306d58d2e87cbed46a72472b62c17b0ec9" 23:52:32 INFO - }, 23:52:32 INFO - "sourcestamp": { 23:52:32 INFO - "repository": "", 23:52:32 INFO - "hasPatch": false, 23:52:32 INFO - "project": "", 23:52:32 INFO - "branch": "fx-team-macosx64-talos", 23:52:32 INFO - "changes": [ 23:52:32 INFO - { 23:52:32 INFO - "category": null, 23:52:32 INFO - "files": [ 23:52:32 INFO - { 23:52:32 INFO - "url": null, 23:52:32 INFO - "name": "https://queue.taskcluster.net/v1/task/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 23:52:32 INFO - } 23:52:32 INFO - ], 23:52:32 INFO - "repository": "", 23:52:32 INFO - "rev": "4dca10306d58d2e87cbed46a72472b62c17b0ec9", 23:52:32 INFO - "who": "maglione.k@gmail.com", 23:52:32 INFO - "when": 1448351439, 23:52:32 INFO - "number": 6699218, 23:52:32 INFO - "comments": "Bug 1208761: [webext] Support l10n.getMessage in content scripts. r=billm", 23:52:32 INFO - "project": "", 23:52:32 INFO - "at": "Mon 23 Nov 2015 23:50:39", 23:52:32 INFO - "branch": "fx-team-macosx64-talos", 23:52:32 INFO - "revlink": "", 23:52:32 INFO - "properties": [ 23:52:32 INFO - [ 23:52:32 INFO - "buildid", 23:52:32 INFO - "20151123230131", 23:52:32 INFO - "Change" 23:52:32 INFO - ], 23:52:32 INFO - [ 23:52:32 INFO - "builduid", 23:52:32 INFO - "e1a21c9e4fc94800ad47e73ca81a94a6", 23:52:32 INFO - "Change" 23:52:32 INFO - ], 23:52:32 INFO - [ 23:52:32 INFO - "pgo_build", 23:52:32 INFO - "False", 23:52:32 INFO - "Change" 23:52:32 INFO - ] 23:52:32 INFO - ], 23:52:32 INFO - "revision": "4dca10306d58d2e87cbed46a72472b62c17b0ec9" 23:52:32 INFO - } 23:52:32 INFO - ], 23:52:32 INFO - "revision": "4dca10306d58d2e87cbed46a72472b62c17b0ec9" 23:52:32 INFO - } 23:52:32 INFO - } 23:52:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 23:52:32 INFO - Running post-action listener: _resource_record_post_action 23:52:32 INFO - ##### 23:52:32 INFO - ##### Running download-and-extract step. 23:52:32 INFO - ##### 23:52:32 INFO - Running pre-action listener: _resource_record_pre_action 23:52:32 INFO - Running main action method: download_and_extract 23:52:32 INFO - mkdir: /builds/slave/test/build/tests 23:52:32 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')]} 23:52:32 INFO - https://queue.taskcluster.net/v1/task/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 23:52:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/test_packages.json 23:52:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/test_packages.json 23:52:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 23:52:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 23:52:36 INFO - Downloaded 1149 bytes. 23:52:36 INFO - Reading from file /builds/slave/test/build/test_packages.json 23:52:36 INFO - Using the following test package requirements: 23:52:36 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 23:52:36 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 23:52:36 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 23:52:36 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 23:52:36 INFO - u'jsshell-mac.zip'], 23:52:36 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 23:52:36 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 23:52:36 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 23:52:36 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 23:52:36 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 23:52:36 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 23:52:36 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 23:52:36 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 23:52:36 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 23:52:36 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 23:52:36 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 23:52:36 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 23:52:36 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 23:52:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:52:36 INFO - https://queue.taskcluster.net/v1/task/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 23:52:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 23:52:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 23:52:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5I7cAY2HQ4WuC3qktLedOw/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 23:52:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5I7cAY2HQ4WuC3qktLedOw/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 23:52:37 INFO - Downloaded 17526945 bytes. 23:52:37 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 23:52:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 23:52:37 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 23:52:40 INFO - Return code: 0 23:52:40 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 23:52:40 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')]} 23:52:40 INFO - https://queue.taskcluster.net/v1/task/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 23:52:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 23:52:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 23:52:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5I7cAY2HQ4WuC3qktLedOw/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 23:52:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5I7cAY2HQ4WuC3qktLedOw/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 23:52:43 INFO - Downloaded 17526945 bytes. 23:52: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 23:52:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 23:52:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 23:52:46 INFO - Return code: 0 23:52: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')]} 23:52:46 INFO - https://queue.taskcluster.net/v1/task/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 23:52:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 23:52:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 23:52:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5I7cAY2HQ4WuC3qktLedOw/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 23:52:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5I7cAY2HQ4WuC3qktLedOw/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 23:52:47 INFO - Downloaded 11130997 bytes. 23:52: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 23:52:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 23:52:47 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 23:52:47 INFO - Return code: 0 23:52: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')]} 23:52:47 INFO - https://queue.taskcluster.net/v1/task/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 23:52:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 23:52:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 23:52:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 23:52:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5I7cAY2HQ4WuC3qktLedOw/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 23:52:50 INFO - Downloaded 109910917 bytes. 23:52:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 23:52:50 INFO - mkdir: /builds/slave/test/properties 23:52:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:52:50 INFO - Writing to file /builds/slave/test/properties/build_url 23:52:50 INFO - Contents: 23:52:50 INFO - build_url:https://queue.taskcluster.net/v1/task/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 23:52:50 INFO - Running post-action listener: _resource_record_post_action 23:52:50 INFO - Running post-action listener: set_extra_try_arguments 23:52:50 INFO - ##### 23:52:50 INFO - ##### Running populate-webroot step. 23:52:50 INFO - ##### 23:52:50 INFO - Running pre-action listener: _resource_record_pre_action 23:52:50 INFO - Running main action method: populate_webroot 23:52:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:52:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:52:51 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 23:52:51 INFO - '../fennec_ids.txt'], 23:52:51 INFO - 'tests': ['tcheck2']}, 23:52:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:52:51 INFO - '--tppagecycles', 23:52:51 INFO - '7'], 23:52:51 INFO - 'tests': ['tsvgm']}}, 23:52:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 23:52:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 23:52:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:52:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 23:52:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 23:52:51 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 23:52:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:52:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:52:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:52:51 INFO - 'talos_options': ['--e10s'], 23:52:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:52:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:52:51 INFO - 'tests': ['damp', 'tps']}, 23:52:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:52:51 INFO - 'talos_options': ['--e10s'], 23:52:51 INFO - 'tests': ['damp', 'tps']}, 23:52:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 23:52:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:52:51 INFO - 'other': {'tests': ['a11yr', 23:52:51 INFO - 'ts_paint', 23:52:51 INFO - 'tpaint', 23:52:51 INFO - 'sessionrestore', 23:52:51 INFO - 'sessionrestore_no_auto_restore']}, 23:52:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 23:52:51 INFO - 'tests': ['a11yr', 23:52:51 INFO - 'ts_paint', 23:52:51 INFO - 'tpaint', 23:52:51 INFO - 'sessionrestore', 23:52:51 INFO - 'sessionrestore_no_auto_restore']}, 23:52:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 23:52:51 INFO - 'tests': ['a11yr', 23:52:51 INFO - 'ts_paint', 23:52:51 INFO - 'tpaint', 23:52:51 INFO - 'sessionrestore', 23:52:51 INFO - 'sessionrestore_no_auto_restore']}, 23:52:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 23:52:51 INFO - 'tests': ['a11yr', 23:52:51 INFO - 'ts_paint', 23:52:51 INFO - 'tpaint', 23:52:51 INFO - 'sessionrestore', 23:52:51 INFO - 'sessionrestore_no_auto_restore']}, 23:52:51 INFO - 'other_l64': {'tests': ['a11yr', 23:52:51 INFO - 'ts_paint', 23:52:51 INFO - 'tpaint', 23:52:51 INFO - 'sessionrestore', 23:52:51 INFO - 'sessionrestore_no_auto_restore']}, 23:52:51 INFO - 'other_nol64': {'tests': ['a11yr', 23:52:51 INFO - 'ts_paint', 23:52:51 INFO - 'tpaint', 23:52:51 INFO - 'sessionrestore', 23:52:51 INFO - 'sessionrestore_no_auto_restore']}, 23:52:51 INFO - 'svgr': {'tests': ['tsvgx', 23:52:51 INFO - 'tsvgr_opacity', 23:52:51 INFO - 'tart', 23:52:51 INFO - 'tscrollx', 23:52:51 INFO - 'cart']}, 23:52:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 23:52:51 INFO - 'tests': ['tsvgx', 23:52:51 INFO - 'tsvgr_opacity', 23:52:51 INFO - 'tart', 23:52:51 INFO - 'tscrollx', 23:52:51 INFO - 'cart']}, 23:52:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:52:51 INFO - 'tests': ['tp5o']}, 23:52:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:52:51 INFO - 'talos_options': ['--e10s'], 23:52:51 INFO - 'tests': ['tp5o']}, 23:52:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:52:51 INFO - 'talos_options': ['--xperf_path', 23:52:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:52:51 INFO - 'tests': ['tp5n']}, 23:52:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:52:51 INFO - 'talos_options': ['--e10s', 23:52:51 INFO - '--xperf_path', 23:52:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:52:51 INFO - 'tests': ['tp5n']}}, 23:52:51 INFO - 'talos.zip': {'path': '', 23:52:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:52:51 INFO - Running post-action listener: _resource_record_post_action 23:52:51 INFO - ##### 23:52:51 INFO - ##### Running create-virtualenv step. 23:52:51 INFO - ##### 23:52:51 INFO - Running pre-action listener: _resource_record_pre_action 23:52:51 INFO - Running main action method: create_virtualenv 23:52:51 INFO - Creating virtualenv /builds/slave/test/build/venv 23:52:51 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 23:52:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:52:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:52:51 INFO - Using real prefix '/tools/python27' 23:52:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:52:51 INFO - Installing distribute.............................................................................................................................................................................................done. 23:52:54 INFO - Installing pip.................done. 23:52:54 INFO - Return code: 0 23:52:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:52: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')]} 23:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:52:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52: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')]} 23:52:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:52:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52: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 0x108caf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c8c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb19bca4cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bd39f0>, '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 0x108932db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108bc68c8>, '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.C0BS0AOWsI/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.GFVPXWxp90/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 23:52: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 23:52: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 23:52:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C0BS0AOWsI/Render', 23:52:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:52:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:52:54 INFO - 'HOME': '/Users/cltbld', 23:52:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:52:54 INFO - 'LOGNAME': 'cltbld', 23:52:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:52:54 INFO - 'MOZ_NO_REMOTE': '1', 23:52:54 INFO - 'NO_EM_RESTART': '1', 23:52:54 INFO - 'PAGER': '/bin/cat', 23:52:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:52:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:52:54 INFO - 'PWD': '/builds/slave/test', 23:52:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:52:54 INFO - 'SHELL': '/bin/bash', 23:52:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GFVPXWxp90/Listeners', 23:52:54 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 23:52:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:52:54 INFO - 'USER': 'cltbld', 23:52:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:52:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:52:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:52:54 INFO - 'XPC_FLAGS': '0x0', 23:52:54 INFO - 'XPC_SERVICE_NAME': '0', 23:52:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:52:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:52: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 23:52:54 INFO - Cleaning up... 23:52:54 INFO - Return code: 0 23:52:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 23:52: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')]} 23:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:52:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52: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')]} 23:52:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:52:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52: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 0x108caf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c8c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb19bca4cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bd39f0>, '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 0x108932db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108bc68c8>, '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.C0BS0AOWsI/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.GFVPXWxp90/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 23:52: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 23:52: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 23:52:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C0BS0AOWsI/Render', 23:52:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:52:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:52:54 INFO - 'HOME': '/Users/cltbld', 23:52:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:52:54 INFO - 'LOGNAME': 'cltbld', 23:52:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:52:54 INFO - 'MOZ_NO_REMOTE': '1', 23:52:54 INFO - 'NO_EM_RESTART': '1', 23:52:54 INFO - 'PAGER': '/bin/cat', 23:52:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:52:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:52:54 INFO - 'PWD': '/builds/slave/test', 23:52:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:52:54 INFO - 'SHELL': '/bin/bash', 23:52:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GFVPXWxp90/Listeners', 23:52:54 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 23:52:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:52:54 INFO - 'USER': 'cltbld', 23:52:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:52:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:52:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:52:54 INFO - 'XPC_FLAGS': '0x0', 23:52:54 INFO - 'XPC_SERVICE_NAME': '0', 23:52:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:52:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:52:55 INFO - Downloading/unpacking psutil>=0.7.1 23:52: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 23:52: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 23:52: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 23:52: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 23:52: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 23:52: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 23:52:57 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 23:52:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 23:52:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:52:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:52:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:52:57 INFO - Installing collected packages: psutil 23:52:57 INFO - Running setup.py install for psutil 23:52:58 INFO - building 'psutil._psutil_osx' extension 23:52: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_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 23:52: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 23:52: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 23:52: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 23:52:58 INFO - building 'psutil._psutil_posix' extension 23:52: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 23:52:58 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 23:52:58 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 23:52:58 INFO - ^ 23:52:59 INFO - 1 warning generated. 23:52:59 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 23:52:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:52:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:52:59 INFO - Successfully installed psutil 23:52:59 INFO - Cleaning up... 23:52:59 INFO - Return code: 0 23:52:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 23:52:59 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')]} 23:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:52:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:59 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')]} 23:52:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:52:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:59 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 0x108caf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c8c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb19bca4cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bd39f0>, '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 0x108932db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108bc68c8>, '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.C0BS0AOWsI/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.GFVPXWxp90/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 23:52:59 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 23:52:59 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 23:52:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C0BS0AOWsI/Render', 23:52:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:52:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:52:59 INFO - 'HOME': '/Users/cltbld', 23:52:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:52:59 INFO - 'LOGNAME': 'cltbld', 23:52:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:52:59 INFO - 'MOZ_NO_REMOTE': '1', 23:52:59 INFO - 'NO_EM_RESTART': '1', 23:52:59 INFO - 'PAGER': '/bin/cat', 23:52:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:52:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:52:59 INFO - 'PWD': '/builds/slave/test', 23:52:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:52:59 INFO - 'SHELL': '/bin/bash', 23:52:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GFVPXWxp90/Listeners', 23:52:59 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 23:52:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:52:59 INFO - 'USER': 'cltbld', 23:52:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:52:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:52:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:52:59 INFO - 'XPC_FLAGS': '0x0', 23:52:59 INFO - 'XPC_SERVICE_NAME': '0', 23:52:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:52:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:52:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:52:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:52:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:52:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:52:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:53:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:53:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 23:53:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:53: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) 23:53:01 INFO - Installing collected packages: mozsystemmonitor 23:53:01 INFO - Running setup.py install for mozsystemmonitor 23:53:01 INFO - Successfully installed mozsystemmonitor 23:53:01 INFO - Cleaning up... 23:53:01 INFO - Return code: 0 23:53:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:53: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')]} 23:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:53:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:53: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')]} 23:53:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:53:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:53: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 0x108caf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c8c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb19bca4cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bd39f0>, '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 0x108932db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108bc68c8>, '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.C0BS0AOWsI/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.GFVPXWxp90/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 23:53: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 23:53: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 23:53:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C0BS0AOWsI/Render', 23:53:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:53:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:53:01 INFO - 'HOME': '/Users/cltbld', 23:53:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:53:01 INFO - 'LOGNAME': 'cltbld', 23:53:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:53:01 INFO - 'MOZ_NO_REMOTE': '1', 23:53:01 INFO - 'NO_EM_RESTART': '1', 23:53:01 INFO - 'PAGER': '/bin/cat', 23:53:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:53:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:53:01 INFO - 'PWD': '/builds/slave/test', 23:53:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:53:01 INFO - 'SHELL': '/bin/bash', 23:53:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GFVPXWxp90/Listeners', 23:53:01 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 23:53:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:53:01 INFO - 'USER': 'cltbld', 23:53:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:53:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:53:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:53:01 INFO - 'XPC_FLAGS': '0x0', 23:53:01 INFO - 'XPC_SERVICE_NAME': '0', 23:53:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:53:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:53:02 INFO - Downloading/unpacking blobuploader==1.2.4 23:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:53:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:53:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:53:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:53:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:53:04 INFO - Downloading blobuploader-1.2.4.tar.gz 23:53:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 23:53:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:53:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:53: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 23:53: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 23:53: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 23:53: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 23:53: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 23:53: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 23:53:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 23:53:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:53:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:53: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 23:53: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 23:53: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 23:53: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 23:53: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 23:53: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 23:53:05 INFO - Downloading docopt-0.6.1.tar.gz 23:53:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 23:53:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:53:05 INFO - Installing collected packages: blobuploader, requests, docopt 23:53:05 INFO - Running setup.py install for blobuploader 23:53:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:53:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:53:05 INFO - Running setup.py install for requests 23:53:06 INFO - Running setup.py install for docopt 23:53:06 INFO - Successfully installed blobuploader requests docopt 23:53:06 INFO - Cleaning up... 23:53:06 INFO - Return code: 0 23:53:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:53:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:53:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:53:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:53:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:53:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:53:06 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 0x108caf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c8c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb19bca4cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bd39f0>, '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 0x108932db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108bc68c8>, '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.C0BS0AOWsI/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.GFVPXWxp90/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 23:53:06 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 23:53:06 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 23:53:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C0BS0AOWsI/Render', 23:53:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:53:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:53:06 INFO - 'HOME': '/Users/cltbld', 23:53:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:53:06 INFO - 'LOGNAME': 'cltbld', 23:53:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:53:06 INFO - 'MOZ_NO_REMOTE': '1', 23:53:06 INFO - 'NO_EM_RESTART': '1', 23:53:06 INFO - 'PAGER': '/bin/cat', 23:53:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:53:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:53:06 INFO - 'PWD': '/builds/slave/test', 23:53:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:53:06 INFO - 'SHELL': '/bin/bash', 23:53:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GFVPXWxp90/Listeners', 23:53:06 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 23:53:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:53:06 INFO - 'USER': 'cltbld', 23:53:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:53:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:53:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:53:06 INFO - 'XPC_FLAGS': '0x0', 23:53:06 INFO - 'XPC_SERVICE_NAME': '0', 23:53:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:53:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:53:06 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-42ZnyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:53:06 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-NNIKbx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:53:06 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-jcDG3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:53:06 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-ZLg2g3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:53:07 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-U7wTJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:53:07 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-pRtVcC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:53:07 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-FFTwGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:53:07 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-dAB0dU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:53:07 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-OJbQ2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:53:07 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-SxpNgf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:53:07 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-cP43GS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:53:07 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-Pv6Xqg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:53:07 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-6cpiqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:53:07 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-ncSj_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:53:08 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-RxAbyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:53:08 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-XDE7AD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:53:08 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-tesyGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:53:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:53:08 INFO - Running setup.py install for manifestparser 23:53:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:53:08 INFO - Running setup.py install for mozcrash 23:53:08 INFO - Running setup.py install for mozdebug 23:53:08 INFO - Running setup.py install for mozdevice 23:53:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:53:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:53:08 INFO - Running setup.py install for mozfile 23:53:09 INFO - Running setup.py install for mozhttpd 23:53:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:53:09 INFO - Running setup.py install for mozinfo 23:53:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:53:09 INFO - Running setup.py install for mozInstall 23:53:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:53:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:53:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:53:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:53:09 INFO - Running setup.py install for mozleak 23:53:09 INFO - Running setup.py install for mozlog 23:53:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:53:09 INFO - Running setup.py install for moznetwork 23:53:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:53:09 INFO - Running setup.py install for mozprocess 23:53:10 INFO - Running setup.py install for mozprofile 23:53:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:53:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:53:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:53:10 INFO - Running setup.py install for mozrunner 23:53:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:53:10 INFO - Running setup.py install for mozscreenshot 23:53:10 INFO - Running setup.py install for moztest 23:53:10 INFO - Running setup.py install for mozversion 23:53:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:53:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:53:10 INFO - Cleaning up... 23:53:10 INFO - Return code: 0 23:53:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:53: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')]} 23:53:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:53:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:53: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')]} 23:53:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:53:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:53: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 0x108caf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c8c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb19bca4cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bd39f0>, '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 0x108932db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108bc68c8>, '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.C0BS0AOWsI/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.GFVPXWxp90/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 23:53: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 23:53: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 23:53:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C0BS0AOWsI/Render', 23:53:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:53:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:53:10 INFO - 'HOME': '/Users/cltbld', 23:53:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:53:10 INFO - 'LOGNAME': 'cltbld', 23:53:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:53:10 INFO - 'MOZ_NO_REMOTE': '1', 23:53:10 INFO - 'NO_EM_RESTART': '1', 23:53:10 INFO - 'PAGER': '/bin/cat', 23:53:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:53:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:53:10 INFO - 'PWD': '/builds/slave/test', 23:53:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:53:10 INFO - 'SHELL': '/bin/bash', 23:53:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GFVPXWxp90/Listeners', 23:53:10 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 23:53:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:53:10 INFO - 'USER': 'cltbld', 23:53:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:53:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:53:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:53:10 INFO - 'XPC_FLAGS': '0x0', 23:53:10 INFO - 'XPC_SERVICE_NAME': '0', 23:53:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:53:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:53:11 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-Jevidn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:53:11 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)) 23:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:53:11 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-5Myaqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:53: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)) 23:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:53:11 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-jmrGVH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:53: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)) 23:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:53:11 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-nJw1HB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:53: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)) 23:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:53:11 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-nlHYZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:53: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)) 23:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:53:11 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-drkvdl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:53: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)) 23:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:53:11 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-PdBmVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:53: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)) 23:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:53:11 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-gQZ2Hw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:53:12 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)) 23:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:53:12 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-jr84fU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:53:12 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)) 23:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:53:12 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-ZbWQoL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:53:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 23:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:53:12 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-rJp2yB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:53: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)) 23:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:53:12 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-DfEtCS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:53: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)) 23:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:53:12 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-VVheS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:53: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)) 23:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:53:12 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-wMbdFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:53: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)) 23:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:53:12 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-Dd_qmx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:53: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)) 23:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:53:12 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-1s2n6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:53: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)) 23:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:53:12 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-m_FOD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:53:13 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)) 23:53:13 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)) 23:53:13 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)) 23:53:13 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)) 23:53:13 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)) 23:53:13 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)) 23:53:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:53:13 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 23:53:13 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 23:53:13 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 23:53:13 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 23:53:13 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 23:53:13 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 23:53:15 INFO - Downloading blessings-1.5.1.tar.gz 23:53:15 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 23:53:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:53:15 INFO - Installing collected packages: blessings 23:53:15 INFO - Running setup.py install for blessings 23:53:15 INFO - Successfully installed blessings 23:53:15 INFO - Cleaning up... 23:53:15 INFO - Return code: 0 23:53:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:53:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:53:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:53:15 INFO - Reading from file tmpfile_stdout 23:53:15 INFO - Current package versions: 23:53:15 INFO - blessings == 1.5.1 23:53:15 INFO - blobuploader == 1.2.4 23:53:15 INFO - docopt == 0.6.1 23:53:15 INFO - manifestparser == 1.1 23:53:15 INFO - mozInstall == 1.12 23:53:15 INFO - mozcrash == 0.16 23:53:15 INFO - mozdebug == 0.1 23:53:15 INFO - mozdevice == 0.47 23:53:15 INFO - mozfile == 1.2 23:53:15 INFO - mozhttpd == 0.7 23:53:15 INFO - mozinfo == 0.9 23:53:15 INFO - mozleak == 0.1 23:53:15 INFO - mozlog == 3.1 23:53:15 INFO - moznetwork == 0.27 23:53:15 INFO - mozprocess == 0.22 23:53:15 INFO - mozprofile == 0.27 23:53:15 INFO - mozrunner == 6.11 23:53:15 INFO - mozscreenshot == 0.1 23:53:15 INFO - mozsystemmonitor == 0.0 23:53:15 INFO - moztest == 0.7 23:53:15 INFO - mozversion == 1.4 23:53:15 INFO - psutil == 3.1.1 23:53:15 INFO - requests == 1.2.3 23:53:15 INFO - wsgiref == 0.1.2 23:53:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:53: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')]} 23:53:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:53:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:53: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')]} 23:53:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:53:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:53: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 0x108caf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c8c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb19bca4cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bd39f0>, '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 0x108932db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108bc68c8>, '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.C0BS0AOWsI/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.GFVPXWxp90/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 23:53: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 23:53: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 23:53:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C0BS0AOWsI/Render', 23:53:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:53:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:53:15 INFO - 'HOME': '/Users/cltbld', 23:53:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:53:15 INFO - 'LOGNAME': 'cltbld', 23:53:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:53:15 INFO - 'MOZ_NO_REMOTE': '1', 23:53:15 INFO - 'NO_EM_RESTART': '1', 23:53:15 INFO - 'PAGER': '/bin/cat', 23:53:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:53:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:53:15 INFO - 'PWD': '/builds/slave/test', 23:53:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:53:15 INFO - 'SHELL': '/bin/bash', 23:53:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GFVPXWxp90/Listeners', 23:53:15 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 23:53:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:53:15 INFO - 'USER': 'cltbld', 23:53:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:53:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:53:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:53:15 INFO - 'XPC_FLAGS': '0x0', 23:53:15 INFO - 'XPC_SERVICE_NAME': '0', 23:53:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:53:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:53:16 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)) 23:53:16 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)) 23:53:16 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)) 23:53:16 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)) 23:53:16 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)) 23:53:16 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)) 23:53:16 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)) 23:53:16 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)) 23:53:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:53:16 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)) 23:53:16 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)) 23:53:16 INFO - Cleaning up... 23:53:16 INFO - Return code: 0 23:53:16 INFO - Running post-action listener: _resource_record_post_action 23:53:16 INFO - Running post-action listener: _start_resource_monitoring 23:53:16 INFO - Starting resource monitoring. 23:53:16 INFO - ##### 23:53:16 INFO - ##### Running install step. 23:53:16 INFO - ##### 23:53:16 INFO - Running pre-action listener: _resource_record_pre_action 23:53:16 INFO - Running main action method: install 23:53:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:53:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:53:16 INFO - Reading from file tmpfile_stdout 23:53:16 INFO - Detecting whether we're running mozinstall >=1.0... 23:53:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:53:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:53:16 INFO - Reading from file tmpfile_stdout 23:53:16 INFO - Output received: 23:53:16 INFO - Usage: mozinstall [options] installer 23:53:16 INFO - Options: 23:53:16 INFO - -h, --help show this help message and exit 23:53:16 INFO - -d DEST, --destination=DEST 23:53:16 INFO - Directory to install application into. [default: 23:53:16 INFO - "/builds/slave/test"] 23:53:16 INFO - --app=APP Application being installed. [default: firefox] 23:53:16 INFO - mkdir: /builds/slave/test/build/application 23:53: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'] 23:53: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 23:53:46 INFO - Reading from file tmpfile_stdout 23:53:46 INFO - Output received: 23:53:46 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 23:53:46 INFO - Running post-action listener: _resource_record_post_action 23:53:46 INFO - ##### 23:53:46 INFO - ##### Running run-tests step. 23:53:46 INFO - ##### 23:53:46 INFO - Running pre-action listener: _resource_record_pre_action 23:53:46 INFO - Running main action method: run_tests 23:53:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:53:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:53:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:53:46 INFO - 2015-11-23 23:53:46.505 screenresolution[1648:9662] starting screenresolution argv=screenresolution get 23:53:46 INFO - 2015-11-23 23:53:46.508 screenresolution[1648:9662] Display 0: 1600x1200x32@60 23:53:46 INFO - 2015-11-23 23:53:46.514 screenresolution[1649:9664] starting screenresolution argv=screenresolution list 23:53:46 INFO - Available Modes on Display 0 23:53:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:53:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:53:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:53:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:53:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:53:46 INFO - Intel Iris: 23:53:46 INFO - Chipset Model: Intel Iris 23:53:46 INFO - Type: GPU 23:53:46 INFO - Bus: Built-In 23:53:46 INFO - VRAM (Dynamic, Max): 1536 MB 23:53:46 INFO - Vendor: Intel (0x8086) 23:53:46 INFO - Device ID: 0x0a2e 23:53:46 INFO - Revision ID: 0x0009 23:53:46 INFO - Displays: 23:53:46 INFO - Display: 23:53:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:53:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:53:46 INFO - Display Serial Number: 1600x1200 60 23:53:46 INFO - Main Display: Yes 23:53:46 INFO - Mirror: Off 23:53:46 INFO - Online: Yes 23:53:46 INFO - Rotation: Supported 23:53:46 INFO - Return code: 0 23:53:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:53:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:53:46 INFO - Python 2.7.3 23:53:46 INFO - Return code: 0 23:53:46 INFO - grabbing minidump binary from tooltool 23:53: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')]} 23:53: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 0x108bd39f0>, '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 0x108932db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108bc68c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:53: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 23:53: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 23:53:46 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:53:46 INFO - Return code: 0 23:53:46 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 23:53:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:53:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:53:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 23:53:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:53: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/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0052', '--webServer', 'localhost'] in /builds/slave/test/build 23:53: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/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0052 --webServer localhost 23:53:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C0BS0AOWsI/Render', 23:53:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:53:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:53:46 INFO - 'HOME': '/Users/cltbld', 23:53:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:53:46 INFO - 'LOGNAME': 'cltbld', 23:53:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:53:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 23:53:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:53:46 INFO - 'MOZ_NO_REMOTE': '1', 23:53:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:53:46 INFO - 'NO_EM_RESTART': '1', 23:53:46 INFO - 'PAGER': '/bin/cat', 23:53:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:53:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:53:46 INFO - 'PWD': '/builds/slave/test', 23:53:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:53:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:53:46 INFO - 'SHELL': '/bin/bash', 23:53:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GFVPXWxp90/Listeners', 23:53:46 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 23:53:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:53:46 INFO - 'USER': 'cltbld', 23:53:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:53:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:53:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:53:46 INFO - 'XPC_FLAGS': '0x0', 23:53:46 INFO - 'XPC_SERVICE_NAME': '0', 23:53:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:53: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/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0052', '--webServer', 'localhost'] with output_timeout 3600 23:53:47 INFO - mozversion INFO | application_buildid: 20151123230131 23:53:47 INFO - mozversion INFO | application_changeset: 4dca10306d58d2e87cbed46a72472b62c17b0ec9 23:53:47 INFO - mozversion INFO | application_display_name: Nightly 23:53:47 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:53:47 INFO - mozversion INFO | application_name: Firefox 23:53:47 INFO - mozversion INFO | application_remotingname: firefox 23:53:47 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 23:53:47 INFO - mozversion INFO | application_vendor: Mozilla 23:53:47 INFO - mozversion INFO | application_version: 45.0a1 23:53:47 INFO - mozversion INFO | platform_buildid: 20151123230131 23:53:47 INFO - mozversion INFO | platform_changeset: 4dca10306d58d2e87cbed46a72472b62c17b0ec9 23:53:47 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 23:53:47 INFO - mozversion INFO | platform_version: 45.0a1 23:53:47 INFO - 2015-11-23 23:53:47,065 DEBUG : using testdate: 1448351627 23:53:47 INFO - 2015-11-23 23:53:47,065 DEBUG : actual date: 1448351627 23:53:47 INFO - 2015-11-23 23:53:47,074 INFO : starting webserver on 'localhost:49271' 23:53:47 INFO - 2015-11-23 23:53:47,075 INFO : Starting test suite t-yosemite-r7-0052 23:53:47 INFO - 2015-11-23 23:53:47,075 INFO : Starting test dromaeo_css 23:53:47 INFO - 2015-11-23 23:53:47,075 DEBUG : operating with platform_type : mac_ 23:53:47 INFO - 2015-11-23 23:53:47,076 INFO : Initialising browser for dromaeo_css test... 23:53:47 INFO - 2015-11-23 23:53:47,089 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/tmpaWSgmu/profile http://localhost:49271/getInfo.html 23:53:49 INFO - 2015-11-23 23:53:49,358 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 23:53:49 INFO - 2015-11-23 23:53:49,358 DEBUG : BROWSER_OUTPUT: colorDepth:24 23:53:49 INFO - 2015-11-23 23:53:49,358 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 23:53:49 INFO - 2015-11-23 23:53:49,359 DEBUG : BROWSER_OUTPUT: __metrics 23:53:49 INFO - 2015-11-23 23:53:49,375 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:53:49 INFO - 2015-11-23 23:53:49,624 DEBUG : BROWSER_OUTPUT: console.error: 23:53:49 INFO - 2015-11-23 23:53:49,628 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 23:53:49 INFO - 2015-11-23 23:53:49,628 DEBUG : BROWSER_OUTPUT: Stack: 23:53:49 INFO - 2015-11-23 23:53:49,628 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 23:53:49 INFO - 2015-11-23 23:53:49,628 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 23:53:49 INFO - 2015-11-23 23:53:49,628 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 23:53:49 INFO - 2015-11-23 23:53:49,628 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 23:53:49 INFO - 2015-11-23 23:53:49,629 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 23:53:49 INFO - 2015-11-23 23:53:49,629 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 23:53:49 INFO - 2015-11-23 23:53:49,629 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 23:53:49 INFO - 2015-11-23 23:53:49,629 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 23:53:49 INFO - 2015-11-23 23:53:49,629 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 23:53:49 INFO - 2015-11-23 23:53:49,629 DEBUG : BROWSER_OUTPUT: 23:53:50 INFO - 2015-11-23 23:53:50,001 INFO : Browser initialized. 23:53:50 INFO - 2015-11-23 23:53:50,002 INFO : Running cycle 1/1 for dromaeo_css test... 23:53:50 INFO - 2015-11-23 23:53:50,002 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/tmpaWSgmu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 23:54:01 INFO - 2015-11-23 23:54:01,894 DEBUG : BROWSER_OUTPUT: RSS: Main: 226713600 23:54:01 INFO - 2015-11-23 23:54:01,895 DEBUG : BROWSER_OUTPUT: 23:54:53 INFO - 2015-11-23 23:54:53,635 DEBUG : BROWSER_OUTPUT: 1448351693627 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] 23:57:03 INFO - 2015-11-23 23:57:03,711 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 23:57:05 INFO - 2015-11-23 23:57:05,022 DEBUG : BROWSER_OUTPUT: RSS: Main: 349016064 23:57:05 INFO - 2015-11-23 23:57:05,022 DEBUG : BROWSER_OUTPUT: 00:00:07 INFO - 2015-11-24 00:00:07,589 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 00:00:08 INFO - 2015-11-24 00:00:08,179 DEBUG : BROWSER_OUTPUT: RSS: Main: 359313408 00:00:08 INFO - 2015-11-24 00:00:08,180 DEBUG : BROWSER_OUTPUT: 00:03:10 INFO - 2015-11-24 00:03:10,104 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 00:03:10 INFO - 2015-11-24 00:03:10,688 DEBUG : BROWSER_OUTPUT: RSS: Main: 359477248 00:03:10 INFO - 2015-11-24 00:03:10,688 DEBUG : BROWSER_OUTPUT: 00:06:12 INFO - 2015-11-24 00:06:12,635 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 00:06:13 INFO - 2015-11-24 00:06:13,233 DEBUG : BROWSER_OUTPUT: RSS: Main: 318926848 00:06:13 INFO - 2015-11-24 00:06:13,233 DEBUG : BROWSER_OUTPUT: 00:09:16 INFO - 2015-11-24 00:09:16,165 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 00:09:16 INFO - 2015-11-24 00:09:16,791 DEBUG : BROWSER_OUTPUT: RSS: Main: 322797568 00:09:16 INFO - 2015-11-24 00:09:16,792 DEBUG : BROWSER_OUTPUT: 00:12:19 INFO - 2015-11-24 00:12:19,315 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 00:12:19 INFO - 2015-11-24 00:12:19,578 DEBUG : BROWSER_OUTPUT: RSS: Main: 363696128 00:12:19 INFO - 2015-11-24 00:12:19,578 DEBUG : BROWSER_OUTPUT: 00:12:19 INFO - 2015-11-24 00:12:19,578 DEBUG : BROWSER_OUTPUT: __start_tp_report 00:12:19 INFO - 2015-11-24 00:12:19,578 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 00:12:19 INFO - 2015-11-24 00:12:19,578 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 00:12:19 INFO - 2015-11-24 00:12:19,578 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 00:12:19 INFO - 2015-11-24 00:12:19,578 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3383.3064221834525;3454.6545345465474;3497.352989696906;3507.5790905091394;3535.4166562517194;5697.4302569743;5840.153177789218;5863.472287494124;5870.090136028912;5880.794172203969;4927.2855435961765;5798.710064496769;5801.216835727176;5917.408259174081;5925.762969481227;5152.639315247934;5170.172772356424;5170.638055336128;5175.5600773934075;5249.737513124348;4767.65868576118;5311.990721762872;5358.571314294847;5374.435684253156;5396.892062158754;5122.359705036871;5174.896502069938;5186.325777648919;5301.655392399501;5311.9468805311835;5239.659422137549;5262.05283049051;5263.184206448007;5267.47325267474;5272.051030814452;5137.7944882204665;5183.688978661293;5221.6083793715625;5230.895382092337;5241.8165364212455;5689.487946084831;5739.942600574024;5743.741531631086;5745;5750.511206547449;6308.526860485482;6322.083297921776;6324.7470101195895;6334.398232167937;6341.936580634227;6152.753889844401;6191.87616247677;6233.407826256498;6283.246010478726;6296.150019747367;5896.587238893237;5960.5827592068135;5970.432808883149;5974;6012.518998480111;6296.622202667763;6347.587406818542;6353.61878287295;6356.269029061625;6370.713317900706;5138.460461651547;6068.393160683984;6121.544430002081;6134.6625935573975;6241.563090583615;6314;6315.273743519462;6324.3991820776955;6333.588316759396;6334.049892516067;6271.592346497463;6288.968555157195;6295.874082518416;6302.968485157545;6309.211348581427;6096.774513597423;6161.630302181883;6184.536159787944;6227.9377206227355;6273.341299163522;4956.826511072095;4997.625178111583;5009.198528235464;5010.3737032870895;5034.446210916796;4477.082198149372;4483.314935892001;4484.080763443486;4522.072975040109;4543.182227199136;5627.155926610959;5685.829425117253;5699.943000570024;5752.971235143881;5776.682282474504;5349.919751203735;6222.595531290452;6264.21697287839;6267.1539342189135;6297.4962003039645;5746.942530574641;5750.6262092963825;5761.8559536011935;5763.9135412968835;5787.305523337226;5289.285946397187;5396.9730151348995;5407.621466497386;5421.647592906448;5431.4840090191365;6156.26124865019;6267.341929097379;6287.056941458726;6291.339409362043;6317.273513546001;6265.091561723616;6293.150424692608;6297.1813664223355;6304.905426418699;6306.621602703853;6318;6386.616802991835;6395.392437718409;6403.64779937108;6407.711652975534;6095.939040609537;6165.383461653799;6176.7838125665385;6184;6278.529110316653;6154.476869466145;6272.529560283088;6283.3402492737605;6285.622862628257;6294.496440284858;6140.846478838065;6154.323024467394;6180.536459765445;6189.412005859616;6207.565470417027;6004.669743164168;6180.783672571439;6191.535634827316;6192;6192.318844926965;5734.9390362783015;5845.912311315248;5863.618864773776;5868.383819699041;5872.882542349214;5689.032864412977;5728.825590753802;6154.78458253959;6170.6914654268;6185.659788711664;5274.103402421674;5985.940140598538;6027.057812593806;6059.33347331802;6083.270007599116 00:12:19 INFO - 2015-11-24 00:12:19,580 DEBUG : BROWSER_OUTPUT: |1;ext.html;556.9804386938713;571.9885602287954;576.5790972590006;580.2340909998803;604.8447465341197;32147.03558893234;32445.351092978126;32460.837695811548;32534.0239792806;32560;40030.59969400305;40559.79720101403;40591;40616.78149655515;40643.796781016055;9784.608615655383;9967.352122112075;9975.152112070482;9975.351602145873;10021.949890250575;8799.692010779623;8925.330600204978;8940.821183576325;9750.268729845255;9874.506274686273;11895.226810257349;12037.337946412943;12048.57829975951;12062.095342849278;12079.516819327217;11663.650090497256;11726.530938762438;11738;11747;11757.823632645517;8842.867356989651;8943.55282235892;8952;11737.413129343498;11757.941210293979;41020.974475638046;41320.586794131974;41385.965350866165;41419;41449.79275103635;3194.3291908699202;3270.73834093272;3282.655321191264;3318.6183588887347;3617.8733744319084;28389.116660454714;28789.856050719824;29215.41569168605;29245.268868278465;29303.87599216728;2712.755851973312;2803.8457884816326;2852.443773464175;2923.605313282701;2989.491786396318;495882;501241.99999999633;503243;505542;508557;64626.353736462035;64915;64990.025149622794;65078.34921650818;65176.67411662911;67261.6547669044;67329.3267067323;67425.3257467419;67551.66224168848;67561.32438675649;15857.444989425314;16240.431584894472;16252;16261.430849920196;16266.51200463988;12349.3825308736;12400.379981000913;12407.828629989715;12410.627681169579;12430.689232769253;19226.423207303804;19734.013299334976;19781.60436791256;19799.802001979795;19834.20663173457;8993.775155621162;9188.724338269863;9190.862137067948;9196.770080747901;9237.630494780133;940.5438362394233;963.6386355116831;964.6671898195111;985;1095.7315457712912;29424.411511769646;29531.114066578037;29954.40091198164;30007.399852002836;30118.397632047676;892.9374044886564;1089.3844977587637;1091.1380009792333;1165.5862168930078;1251.499400239893;14560;14717.44435112332;14766.966312358247;14874.405023799143;14902.850971490363;542470;545469;545485;704824;705435;46414;56967.43032569704;57704;57940.42059579435;58052.09739513092;1329.6808765896308;1331.7003674173427;1424.480064776349;1438.467766926223;1447.1100273332036;26172;28793.42413151767;29620.703792961795;29894;30305.69694303029;55340.44659553353;55614.72192639173;55759;55775;55873.72063139658;465760;467413;468594;469269;470726;30434.39131217319;31527.84236078805;31546.684533154374;31560.42373855824;31560.52659210068;44725.776371117936;45141.32288015616;45141.32288015616;45273.32090018586;45855.85360366017;35424.645753542136;36713;37522;37743.62256377401;38315;36588;36963.63036369602;37086;37410.62589374071;37675;34484.65515344815;35342;35521;35570.822145889106;35594.82202589074;30545;31040.53439198459;31377.68622313839;31537.526937095503;31623.84188079045;21202.15191392327;22372.105115795835;24099.51800963936;24219.546827190425;24683.113463019694 00:12:19 INFO - 2015-11-24 00:12:19,583 DEBUG : BROWSER_OUTPUT: |2;jquery.html;341.7866573663494;347.272464187527;366.543653151826;369.73563901810206;373.32241980804855;16180.110093944828;16216.594585135377;19476.90261548692;20118.09468573914;20867;14920.626984325398;19281.61436771264;19635.705464418046;19938.900305498453;19951.30170444031;5741.224934633834;5913.497352725023;5947.286325640907;6588.934110658904;6765.729370825161;4005.1388951375448;4123.092919557693;4135.35901935199;4398.73607583546;5869.941300587004;5995.760169593211;5996.040633498641;6014.5188384929315;6018.7893423730175;6025.638461692312;5823.737931793058;6014.518838492954;6018.729157187937;6025.3372129065765;6039.969800150993;5636.251023955542;5677.120046392815;5728.283964504437;5732.111522713986;5750.079987202028;24057.75942240573;24597.877010614833;24879.87560062206;25030.37424064395;25979.830907609015;2011.9798802012085;2035.0842121045441;2044.621744977169;2070.2960993262213;2103.747550293959;9726.805463890683;10095.697129086138;11313.434328283634;15362;15524.844751552566;1812.3837895115591;1819.9909000455045;1834.477174005402;1869.401791426744;1908.1985566062149;89379;113704;114071.99999999917;115242.27136592958;116419;19338.4198474046;19467.318643847397;19606.411807645793;19642.60714785696;19670.508237294183;29071.709282907323;29099.12702618925;29119;29136.41727165445;29153.85423072871;10368.170546356274;10371.429571373495;10386.792264154827;10408.970250801021;10451.268411211142;8762.036176020632;8815.911840881638;8840.62970239614;8846.894138232721;8909.73270801864;8860;8887;8892.377533572588;8939.016708162097;8941.37410381267;2973.3012742005612;3452.5166476693284;3503.597086335053;3516.367053930317;3568.13104988831;827.3960009193322;845.945013574128;914.291424146292;988.619381538113;997.9800403991879;19831.504212394804;20175;20489.385318440174;21118;21339.35981920545;812.427238796647;877.2499512916493;914.9542522873962;918.6555041859302;995.3665686230609;8583.699570515002;9899.950500247596;10476.266661333786;10489.160867130611;10518;765385.1730741422;785545.072274635;792077;792813;798963;90927.54536227277;110662;115427;115984;123058;977.9559919803626;1169.3977601535216;1173.8239264110452;1175.9706007349714;1184.265755231762;18028.729569056737;18205.908970455064;18245.54386140357;18300.633987319914;18520.536986575444;53523.732381337846;53831.19253211284;55974.44025559692;57946.4205357941;58159;72872.27127728655;72936.27063729506;73017.6349118251;75175.24824751682;75201.6239918797;9755.756106097404;9848.458334791656;10018.148457381205;10037.548310325907;10048.849267261143;11965.282083075042;11992.460339284578;12062;12083.033357331567;18933.526661833563;16106.215039465482;16115.113668748332;16375.181240938144;16592.668146637243;16608.00351978885;15536.844631553991;15743;15904.966177198445;15987.8401215991;16137.273822677773;15931.601709957344;16490.58773530671;16507.58731031734;16517.33930642761;17123.97256164634;9622;9661.372010819274;9767.316287860065;9771.706848794547;9788.657396991355;14137.43450261978;15674.843251567338;15795.052296862224;16205.837941620433;16387.83612163863 00:12:19 INFO - 2015-11-24 00:12:19,585 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1593.3387644127688;1595.7845690831734;1856.9442916712496;1871.8876867387953;1895.5829717462154;8415;8599.78500537486;8607.440516366432;8614.52620105894;8629.956850215756;8421.91578084219;8436.156384361577;8442.704505342313;8448.788780280496;8452.535110568917;2329.0683726509365;2362.137819695807;2375.2161786610463;2375.7861792438675;2383.2254517281867;2368.786809187173;2399.328188107324;2412.107520217522;2415.2029830156007;2416;2125.3517677108475;2166.750823655284;2176.260071575664;2374.41826752445;2385.8568485890814;1977.5253939054596;2315.409570559505;2336.4509340305017;2356.658284548748;2360.5514952159033;2344.191254017361;2392.3899405651623;2400.867952262625;2401.0995876546294;2407;7678.769636910845;7884.250996155413;8277.875831862466;8414.200650938152;8493.617787199591;5090.261912022773;5174.637775355689;5181.4041385240425;5188.507091826271;5192.299039629639;3492.1618811485314;3566.465030245458;3613.403788374915;3637.345277849986;3641.9453708194396;1058.185197398007;1062.3519653011733;1065.579096256982;1079.9730006749814;1081.4481219450035;10997.955194256532;11080.002799748061;11088;11102.944485277603;11128.944355278252;4651.139539185261;4682.601978831769;4719.811207551728;4735.479097299294;4749.62003039756;9739;9748.220142388593;9752.46361450127;9767.755806104762;9783.608655653694;5209.453007434241;5218.269442278084;5220.321358223407;5220.425753167148;5223.190405487156;4698.248280275139;4743.146233677971;4744.5729884309885;4745.786439610226;4751.097291514601;3633.3823250047553;3714.647108524686;3740.588535261119;3745.6816170625257;3753.774773513598;1225.7854875396947;1231.322772475135;1234.0559472003924;1234.4383305595932;1243.639344590077;1327.2633688303085;1331.4873773597042;1356.986430135686;1364.2019418640207;1399.9090059146122;7757.806054848674;7898.684052637945;7899.249571290718;7904;7904.486208396436;497.72127608539336;507.42914221500814;512.116598866959;512.5233532814518;514.3776031002454;5952.642841429528;6018.548608854353;6183.536234782319;6254.3745625437095;6263.937360626426;8662.523561204194;9366.484843333683;9972.152367048882;10111.696649100539;10243.897561024443;9849.75375615601;10022.498875056364;10031.849522257173;10108.24188185889;10130.08829205375;7828.647710853025;7894.881576776353;7976.2422569856935;7979.3616510679;7982.720604778805;7170.211276759656;7587.393008559192;7869.409794265339;7873.803154921173;7893.802654933673;8812.383133180872;9008.684696035607;9019.052999434965;9040.593173307348;9228.35401521887;9076.455412675261;9284.118008789153;9394.342396032212;9397.483138427178;9434.85847712271;7320.707171713285;7328.120625524971;7340.339369456561;7374.225706300976;7412.1846596875375;7950.284474397332;8003.5197888126895;8015.639296231567;8020.117787043538;8022.9598852005365;7404.925950740424;7460.0301960744755;7520.924790752022;7637.236276372319;7637.541747495168;7339.522931009467;7371.078615173104;7438.070241219848;7455.962720186364;7478.588677622565;7466.664000119899;7518.812029699301;7525.134609519975;7535.773926782205;7536.7362142324755;6240.563160578716;6829.6243706596615;6872.759453419107;6891.827704307432;6894.931050689429;6602.867942641216;6635.8009259722285;6652.866942661217;6680.298568650416;6695.564788288746 00:12:19 INFO - 2015-11-24 00:12:19,586 DEBUG : BROWSER_OUTPUT: |4;prototype.html;273.73721227621485;284.86041839498654;332.34859675036927;337.8564110253142;347.0888916593941;6463.806085817427;6599.241087274965;6654.201495820496;6728.125343705324;6741.730330786762;5295.735213239333;6645.335466453353;6661.63361015144;6663.733450661967;6670.266270710218;4346.630536404409;4888.584470320027;4889.535494128052;4902.558769710726;4916.237983112624;4438.911221775563;4774.28385742138;4854.199057155565;4871.415430148387;4912.140375434303;4823.662343635947;4834.951650483503;4839.903201935959;4845.951540484603;4848.515148485141;4583.335416364608;4817.494163112875;4843.9515604843855;4849.151398505247;4862.6839255448285;4022.456968309299;4023.6781057515327;4026.4900662251657;4068.613481719232;4189.518205406387;6278.121063051177;6310;6379.457746091588;6385.936140638627;6406.487481001509;5802.100674395476;5808.4191580842;5818.621789583706;5819.7090145492975;5819.854503637443;6608.207015158164;6678.232003319632;6820.386165245102;7008.264132266089;7011.684474198673;4724.95275047252;4738.526147385269;4739.573438390527;4744.169770290186;4753.33453316536;7511.699532018767;7516.060492438445;7518.962405187939;7522.586257755821;7531.246875312425;3857.305684976675;4434.445694288214;4797.584712509818;4800.447948485899;4816.036792641486;4725.3384526166365;4744.976275118672;4745.2882067690125;4745.311929770164;4748.216544270157;4598.517155698671;5627.71861406928;5635.21107045014;5650.152477128464;5654.208410822406;5957.106434034843;7078.301207710112;7081.150261968597;7090.361867431956;7100.360967512948;1577.8895477316478;1600.7678886561384;1646.1769115442278;1649.7277949138258;1651.0176445015197;892.3040028777564;989.980200395988;1053.5311786255043;1067.9800790245297;1068.4871261794383;5812.854678632983;6483.092367068614;6488.188976377953;6491.415772580491;6501.317361676955;5827.388124246978;7310.305520975605;7323.0480037595835;7323.963380183065;7353.70585176587;6253.1245625612455;6427.325130861286;6441.774537891151;6452.870942581122;6470.45001174896;3827.559830619459;3869.941950870739;3870.6903447724676;3871.8064096795047;3884.3590807517007;7402.259774022555;7590.127135379502;7614.8096297593;7623.199564045695;7626.351760100453;7455.776326710207;7658.387329013777;7688.154303026663;7711.383089352838;7716.2669546393;7485.288897554724;7684.615769211517;7684.884726729216;7686.116096648957;7717.884231736529;5936.5844390892225;7377.151627562685;7405.629718513945;7408.62956852166;7418.332350088518;7296.270372962661;7318.268173182639;7325.706971721072;7327.596982165819;7328.670209840463;7441.144268408986;7696.384289256958;7723.382129429745;7739.032620922385;7746.612669366396;4641.257398816173;4683.133620280123;4693.389859318267;4696.2251228548275;4700.811967521261;7418.1839997599145;7421.666025028779;7444.143923448873;7450.813729656585;7464.552126872188;6914.55055421396;7135.964320178366;7157.427405807419;7168.53404528704;7173.497855150089;7147.428205743632;7154.8177805767655;7156.785296441115;7160;7170.139583250043;6731.427828634621;6971.616561088986;6971.651417429007;6981.5461994970165;6986.720531178899;5750.424957504383;6137.895178867847;6440.774572889926;7138.821529461805;7142.642867856483;6985.231624521197;6990.161180658353;6990.23107458169;6999.09011828459;6999.515172113826 00:12:19 INFO - 2015-11-24 00:12:19,589 DEBUG : BROWSER_OUTPUT: |5;yui.html;744.5718711740749;761.9466637335386;789.6841263494604;816.1878930464185;844.9873251901219;13438.798418023725;13763.449462021532;13780.655483612914;13784.104033237845;13784.310784460788;13998.230097344642;14116;14116.858831411682;14117.57647270581;14122.43510259591;767.1561282589136;769.461377036077;774.3224678406394;960.3325688646394;967.7483854197924;955.8661787349777;966.0436168193509;968.3608818180003;970.8786401699788;972.6206779356057;1011.8532812742149;1020.3265844542603;1022.982132777887;1024.2727663359024;1026.112412762962;805.0500409516768;805.4402190477621;1005.0452070533023;1014.2342531388828;1030.6856408795315;764.7094104240408;768.5926458976751;771.656612807301;772.4168252968973;773.9496932699357;14666.853331466655;14863.33115009827;14882.330295136637;14913.956023078388;14922.2538873057;12486.81269780954;12629.810552841715;12827.166234194747;12858.099933004694;13095.738085238338;9263.775702417037;10066.513750006265;10223.131033862132;10287.177025837915;10433.634822781241;3520.2431477232262;3565.2156525564333;3577.94633080504;3583.6595523425235;3778.9055273618105;78982;81555;83312.16687833166;84141;84250.57874710648;9593.232541396672;9609.327347085777;9645.035496450299;9826.115649591571;9914.80170396588;22288;22295;22304.996275167658;22314.21900233484;22355.217567385065;7219;7228.49400541957;7245.492815502969;7324.08448943882;7406.7037318506655;3903.316919539069;3958.8614398495915;3995.34076877312;4004.979975100106;4012;2940.911772646824;3487.2502411981545;3540.238848647553;3546.5212196353677;3552.946705799415;628.0558095162387;629.468099455959;631.1479502671357;650.632392698124;654.1332734127301;516.5583426170646;517.6531723745024;531.7766538054027;555.5444535480867;621.3227581935621;8827.779305517413;9200.355975081813;9210.401323913924;9217.308701847254;9218.492982885871;548.5748544877752;595.4194660206351;606.7724603273772;613.5980932489226;624.3382015064046;3726.571444283888;3743.812809359521;3862.1117143057254;3912;4059.594040595917;90016.09983900208;91392.08607913836;91667;91906.54046729724;92326.53836730773;78136.2186378129;78180;78331;79176;79777;66507;66606;66813.66593167002;67195.32804671988;68214.65892670605;8067.193280672121;8293.502389856629;8400.28597569189;8894.155055269739;9064.365494415328;50510.74744626253;50889.74555127349;51515;52413.47586524086;52824.47175528196;72587;73235;73574.63212683902;74220;75645;10881.401522916;10951.83572246433;10974.506147223234;11501.424928753362;11703.88296117062;11846.348450835287;11978.700532486757;12020.278783273032;12023.977961872988;12686.555970540987;10032.498375081363;10053.547590358305;10100.191984641064;10102.69691909244;10158.644447444303;11400.828987565359;11446.656600302003;11476.368799715761;11728.88575585318;12231.75536489283;11142.832857507306;11261.380624065756;11364.54541818318;11366.772664546497;11474.139439541901;9871.555779989774;9923.508566146002;9961.452120133463;10203.795924081625;10374;8495.853059836843;9682.225421966366;9822.901770982198;10037.849432258668;10070.546825392728 00:12:19 INFO - 2015-11-24 00:12:19,590 DEBUG : BROWSER_OUTPUT: __end_tp_report 00:12:19 INFO - 2015-11-24 00:12:19,590 DEBUG : BROWSER_OUTPUT: __start_cc_report 00:12:19 INFO - 2015-11-24 00:12:19,590 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1107 00:12:19 INFO - 2015-11-24 00:12:19,590 DEBUG : BROWSER_OUTPUT: __end_cc_report 00:12:19 INFO - 2015-11-24 00:12:19,590 DEBUG : BROWSER_OUTPUT: __startTimestamp1448352739574__endTimestamp 00:12:19 INFO - 2015-11-24 00:12:19,590 DEBUG : BROWSER_OUTPUT: 00:12:19 INFO - 2015-11-24 00:12:19,590 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 00:12:19 INFO - 2015-11-24 00:12:19,591 DEBUG : BROWSER_OUTPUT: Number of tests: 6 00:12:19 INFO - 2015-11-24 00:12:19,591 DEBUG : BROWSER_OUTPUT: 00:12:19 INFO - 2015-11-24 00:12:19,591 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5766.48 Median:5970.43 stddev:636.10 (10.7%) stddev-sans-first:609.96 00:12:19 INFO - 2015-11-24 00:12:19,591 DEBUG : BROWSER_OUTPUT: Values: 3383.3 3454.7 3497.4 3507.6 3535.4 5697.4 5840.2 5863.5 5870.1 5880.8 4927.3 5798.7 5801.2 5917.4 5925.8 5152.6 5170.2 5170.6 5175.6 5249.7 4767.7 5312.0 5358.6 5374.4 5396.9 5122.4 5174.9 5186.3 5301.7 5311.9 5239.7 5262.1 5263.2 5267.5 5272.1 5137.8 5183.7 5221.6 5230.9 5241.8 5689.5 5739.9 5743.7 5745.0 5750.5 6308.5 6322.1 6324.7 6334.4 6341.9 6152.8 6191.9 6233.4 6283.2 6296.2 5896.6 5960.6 5970.4 5974.0 6012.5 6296.6 6347.6 6353.6 6356.3 6370.7 5138.5 6068.4 6121.5 6134.7 6241.6 6314.0 6315.3 6324.4 6333.6 6334.0 6271.6 6289.0 6295.9 6303.0 6309.2 6096.8 6161.6 6184.5 6227.9 6273.3 4956.8 4997.6 5009.2 5010.4 5034.4 4477.1 4483.3 4484.1 4522.1 4543.2 5627.2 5685.8 5699.9 5753.0 5776.7 5349.9 6222.6 6264.2 6267.2 6297.5 5746.9 5750.6 5761.9 5763.9 5787.3 5289.3 5397.0 5407.6 5421.6 5431.5 6156.3 6267.3 6287.1 6291.3 6317.3 6265.1 6293.2 6297.2 6304.9 6306.6 6318.0 6386.6 6395.4 6403.6 6407.7 6095.9 6165.4 6176.8 6184.0 6278.5 6154.5 6272.5 6283.3 6285.6 6294.5 6140.8 6154.3 6180.5 6189.4 6207.6 6004.7 6180.8 6191.5 6192.0 6192.3 5734.9 5845.9 5863.6 5868.4 5872.9 5689.0 5728.8 6154.8 6170.7 6185.7 5274.1 5985.9 6027.1 6059.3 6083.3 00:12:19 INFO - 2015-11-24 00:12:19,591 DEBUG : BROWSER_OUTPUT: 00:12:19 INFO - 2015-11-24 00:12:19,591 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:66709.98 Median:35545.91 stddev:141914.47 (399.2%) stddev-sans-first:142225.66 00:12:19 INFO - 2015-11-24 00:12:19,591 DEBUG : BROWSER_OUTPUT: Values: 557.0 572.0 576.6 580.2 604.8 32147.0 32445.4 32460.8 32534.0 32560.0 40030.6 40559.8 40591.0 40616.8 40643.8 9784.6 9967.4 9975.2 9975.4 10021.9 8799.7 8925.3 8940.8 9750.3 9874.5 11895.2 12037.3 12048.6 12062.1 12079.5 11663.7 11726.5 11738.0 11747.0 11757.8 8842.9 8943.6 8952.0 11737.4 11757.9 41021.0 41320.6 41386.0 41419.0 41449.8 3194.3 3270.7 3282.7 3318.6 3617.9 28389.1 28789.9 29215.4 29245.3 29303.9 2712.8 2803.8 2852.4 2923.6 2989.5 495882.0 501242.0 503243.0 505542.0 508557.0 64626.4 64915.0 64990.0 65078.3 65176.7 67261.7 67329.3 67425.3 67551.7 67561.3 15857.4 16240.4 16252.0 16261.4 16266.5 12349.4 12400.4 12407.8 12410.6 12430.7 19226.4 19734.0 19781.6 19799.8 19834.2 8993.8 9188.7 9190.9 9196.8 9237.6 940.5 963.6 964.7 985.0 1095.7 29424.4 29531.1 29954.4 30007.4 30118.4 892.9 1089.4 1091.1 1165.6 1251.5 14560.0 14717.4 14767.0 14874.4 14902.9 542470.0 545469.0 545485.0 704824.0 705435.0 46414.0 56967.4 57704.0 57940.4 58052.1 1329.7 1331.7 1424.5 1438.5 1447.1 26172.0 28793.4 29620.7 29894.0 30305.7 55340.4 55614.7 55759.0 55775.0 55873.7 465760.0 467413.0 468594.0 469269.0 470726.0 30434.4 31527.8 31546.7 31560.4 31560.5 44725.8 45141.3 45141.3 45273.3 45855.9 35424.6 36713.0 37522.0 37743.6 38315.0 36588.0 36963.6 37086.0 37410.6 37675.0 34484.7 35342.0 35521.0 35570.8 35594.8 30545.0 31040.5 31377.7 31537.5 31623.8 21202.2 22372.1 24099.5 24219.5 24683.1 00:12:19 INFO - 2015-11-24 00:12:19,592 DEBUG : BROWSER_OUTPUT: 00:12:19 INFO - 2015-11-24 00:12:19,592 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:40955.43 Median:25505.10 stddev:129212.67 (506.6%) stddev-sans-first:129539.15 00:12:19 INFO - 2015-11-24 00:12:19,593 DEBUG : BROWSER_OUTPUT: Values: 341.8 347.3 366.5 369.7 373.3 16180.1 16216.6 19476.9 20118.1 20867.0 14920.6 19281.6 19635.7 19938.9 19951.3 5741.2 5913.5 5947.3 6588.9 6765.7 4005.1 4123.1 4135.4 4398.7 5869.9 5995.8 5996.0 6014.5 6018.8 6025.6 5823.7 6014.5 6018.7 6025.3 6040.0 5636.3 5677.1 5728.3 5732.1 5750.1 24057.8 24597.9 24879.9 25030.4 25979.8 2012.0 2035.1 2044.6 2070.3 2103.7 9726.8 10095.7 11313.4 15362.0 15524.8 1812.4 1820.0 1834.5 1869.4 1908.2 89379.0 113704.0 114072.0 115242.3 116419.0 19338.4 19467.3 19606.4 19642.6 19670.5 29071.7 29099.1 29119.0 29136.4 29153.9 10368.2 10371.4 10386.8 10409.0 10451.3 8762.0 8815.9 8840.6 8846.9 8909.7 8860.0 8887.0 8892.4 8939.0 8941.4 2973.3 3452.5 3503.6 3516.4 3568.1 827.4 845.9 914.3 988.6 998.0 19831.5 20175.0 20489.4 21118.0 21339.4 812.4 877.2 915.0 918.7 995.4 8583.7 9900.0 10476.3 10489.2 10518.0 765385.2 785545.1 792077.0 792813.0 798963.0 90927.5 110662.0 115427.0 115984.0 123058.0 978.0 1169.4 1173.8 1176.0 1184.3 18028.7 18205.9 18245.5 18300.6 18520.5 53523.7 53831.2 55974.4 57946.4 58159.0 72872.3 72936.3 73017.6 75175.2 75201.6 9755.8 9848.5 10018.1 10037.5 10048.8 11965.3 11992.5 12062.0 12083.0 18933.5 16106.2 16115.1 16375.2 16592.7 16608.0 15536.8 15743.0 15905.0 15987.8 16137.3 15931.6 16490.6 16507.6 16517.3 17124.0 9622.0 9661.4 9767.3 9771.7 9788.7 14137.4 15674.8 15795.1 16205.8 16387.8 00:12:19 INFO - 2015-11-24 00:12:19,593 DEBUG : BROWSER_OUTPUT: 00:12:19 INFO - 2015-11-24 00:12:19,593 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5822.78 Median:5587.92 stddev:3034.44 (54.3%) stddev-sans-first:3026.30 00:12:19 INFO - 2015-11-24 00:12:19,595 DEBUG : BROWSER_OUTPUT: Values: 1593.3 1595.8 1856.9 1871.9 1895.6 8415.0 8599.8 8607.4 8614.5 8630.0 8421.9 8436.2 8442.7 8448.8 8452.5 2329.1 2362.1 2375.2 2375.8 2383.2 2368.8 2399.3 2412.1 2415.2 2416.0 2125.4 2166.8 2176.3 2374.4 2385.9 1977.5 2315.4 2336.5 2356.7 2360.6 2344.2 2392.4 2400.9 2401.1 2407.0 7678.8 7884.3 8277.9 8414.2 8493.6 5090.3 5174.6 5181.4 5188.5 5192.3 3492.2 3566.5 3613.4 3637.3 3641.9 1058.2 1062.4 1065.6 1080.0 1081.4 10998.0 11080.0 11088.0 11102.9 11128.9 4651.1 4682.6 4719.8 4735.5 4749.6 9739.0 9748.2 9752.5 9767.8 9783.6 5209.5 5218.3 5220.3 5220.4 5223.2 4698.2 4743.1 4744.6 4745.8 4751.1 3633.4 3714.6 3740.6 3745.7 3753.8 1225.8 1231.3 1234.1 1234.4 1243.6 1327.3 1331.5 1357.0 1364.2 1399.9 7757.8 7898.7 7899.2 7904.0 7904.5 497.7 507.4 512.1 512.5 514.4 5952.6 6018.5 6183.5 6254.4 6263.9 8662.5 9366.5 9972.2 10111.7 10243.9 9849.8 10022.5 10031.8 10108.2 10130.1 7828.6 7894.9 7976.2 7979.4 7982.7 7170.2 7587.4 7869.4 7873.8 7893.8 8812.4 9008.7 9019.1 9040.6 9228.4 9076.5 9284.1 9394.3 9397.5 9434.9 7320.7 7328.1 7340.3 7374.2 7412.2 7950.3 8003.5 8015.6 8020.1 8023.0 7404.9 7460.0 7520.9 7637.2 7637.5 7339.5 7371.1 7438.1 7456.0 7478.6 7466.7 7518.8 7525.1 7535.8 7536.7 6240.6 6829.6 6872.8 6891.8 6894.9 6602.9 6635.8 6652.9 6680.3 6695.6 00:12:19 INFO - 2015-11-24 00:12:19,595 DEBUG : BROWSER_OUTPUT: 00:12:19 INFO - 2015-11-24 00:12:19,595 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5764.49 Median:6467.13 stddev:1861.76 (28.8%) stddev-sans-first:1820.79 00:12:19 INFO - 2015-11-24 00:12:19,596 DEBUG : BROWSER_OUTPUT: Values: 273.7 284.9 332.3 337.9 347.1 6463.8 6599.2 6654.2 6728.1 6741.7 5295.7 6645.3 6661.6 6663.7 6670.3 4346.6 4888.6 4889.5 4902.6 4916.2 4438.9 4774.3 4854.2 4871.4 4912.1 4823.7 4835.0 4839.9 4846.0 4848.5 4583.3 4817.5 4844.0 4849.2 4862.7 4022.5 4023.7 4026.5 4068.6 4189.5 6278.1 6310.0 6379.5 6385.9 6406.5 5802.1 5808.4 5818.6 5819.7 5819.9 6608.2 6678.2 6820.4 7008.3 7011.7 4725.0 4738.5 4739.6 4744.2 4753.3 7511.7 7516.1 7519.0 7522.6 7531.2 3857.3 4434.4 4797.6 4800.4 4816.0 4725.3 4745.0 4745.3 4745.3 4748.2 4598.5 5627.7 5635.2 5650.2 5654.2 5957.1 7078.3 7081.2 7090.4 7100.4 1577.9 1600.8 1646.2 1649.7 1651.0 892.3 990.0 1053.5 1068.0 1068.5 5812.9 6483.1 6488.2 6491.4 6501.3 5827.4 7310.3 7323.0 7324.0 7353.7 6253.1 6427.3 6441.8 6452.9 6470.5 3827.6 3869.9 3870.7 3871.8 3884.4 7402.3 7590.1 7614.8 7623.2 7626.4 7455.8 7658.4 7688.2 7711.4 7716.3 7485.3 7684.6 7684.9 7686.1 7717.9 5936.6 7377.2 7405.6 7408.6 7418.3 7296.3 7318.3 7325.7 7327.6 7328.7 7441.1 7696.4 7723.4 7739.0 7746.6 4641.3 4683.1 4693.4 4696.2 4700.8 7418.2 7421.7 7444.1 7450.8 7464.6 6914.6 7136.0 7157.4 7168.5 7173.5 7147.4 7154.8 7156.8 7160.0 7170.1 6731.4 6971.6 6971.7 6981.5 6986.7 5750.4 6137.9 6440.8 7138.8 7142.6 6985.2 6990.2 6990.2 6999.1 6999.5 00:12:19 INFO - 2015-11-24 00:12:19,596 DEBUG : BROWSER_OUTPUT: 00:12:19 INFO - 2015-11-24 00:12:19,596 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:18491.70 Median:26465.56 stddev:26022.47 (98.3%) stddev-sans-first:26061.35 00:12:19 INFO - 2015-11-24 00:12:19,596 DEBUG : BROWSER_OUTPUT: Values: 744.6 761.9 789.7 816.2 845.0 13438.8 13763.4 13780.7 13784.1 13784.3 13998.2 14116.0 14116.9 14117.6 14122.4 767.2 769.5 774.3 960.3 967.7 955.9 966.0 968.4 970.9 972.6 1011.9 1020.3 1023.0 1024.3 1026.1 805.1 805.4 1005.0 1014.2 1030.7 764.7 768.6 771.7 772.4 773.9 14666.9 14863.3 14882.3 14914.0 14922.3 12486.8 12629.8 12827.2 12858.1 13095.7 9263.8 10066.5 10223.1 10287.2 10433.6 3520.2 3565.2 3577.9 3583.7 3778.9 78982.0 81555.0 83312.2 84141.0 84250.6 9593.2 9609.3 9645.0 9826.1 9914.8 22288.0 22295.0 22305.0 22314.2 22355.2 7219.0 7228.5 7245.5 7324.1 7406.7 3903.3 3958.9 3995.3 4005.0 4012.0 2940.9 3487.3 3540.2 3546.5 3552.9 628.1 629.5 631.1 650.6 654.1 516.6 517.7 531.8 555.5 621.3 8827.8 9200.4 9210.4 9217.3 9218.5 548.6 595.4 606.8 613.6 624.3 3726.6 3743.8 3862.1 3912.0 4059.6 90016.1 91392.1 91667.0 91906.5 92326.5 78136.2 78180.0 78331.0 79176.0 79777.0 66507.0 66606.0 66813.7 67195.3 68214.7 8067.2 8293.5 8400.3 8894.2 9064.4 50510.7 50889.7 51515.0 52413.5 52824.5 72587.0 73235.0 73574.6 74220.0 75645.0 10881.4 10951.8 10974.5 11501.4 11703.9 11846.3 11978.7 12020.3 12024.0 12686.6 10032.5 10053.5 10100.2 10102.7 10158.6 11400.8 11446.7 11476.4 11728.9 12231.8 11142.8 11261.4 11364.5 11366.8 11474.1 9871.6 9923.5 9961.5 10203.8 10374.0 8495.9 9682.2 9822.9 10037.8 10070.5 00:12:19 INFO - 2015-11-24 00:12:19,597 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 00:12:19 INFO - 2015-11-24 00:12:19,597 DEBUG : BROWSER_OUTPUT: 00:12:20 INFO - 2015-11-24 00:12:20,024 INFO : Browser exited with error code: 0 00:12:20 INFO - 2015-11-24 00:12:20,048 INFO : Completed test dromaeo_css (00:18:32) 00:12:20 INFO - 2015-11-24 00:12:20,049 INFO : Starting test kraken 00:12:20 INFO - 2015-11-24 00:12:20,049 DEBUG : operating with platform_type : mac_ 00:12:20 INFO - 2015-11-24 00:12:20,049 INFO : Initialising browser for kraken test... 00:12:20 INFO - 2015-11-24 00:12:20,062 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/tmpjyx_09/profile http://localhost:49271/getInfo.html 00:12:22 INFO - 2015-11-24 00:12:22,155 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 00:12:22 INFO - 2015-11-24 00:12:22,156 DEBUG : BROWSER_OUTPUT: colorDepth:24 00:12:22 INFO - 2015-11-24 00:12:22,156 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 00:12:22 INFO - 2015-11-24 00:12:22,156 DEBUG : BROWSER_OUTPUT: __metrics 00:12:22 INFO - 2015-11-24 00:12:22,172 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:12:22 INFO - 2015-11-24 00:12:22,518 DEBUG : BROWSER_OUTPUT: console.error: 00:12:22 INFO - 2015-11-24 00:12:22,521 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 00:12:22 INFO - 2015-11-24 00:12:22,521 DEBUG : BROWSER_OUTPUT: Stack: 00:12:22 INFO - 2015-11-24 00:12:22,522 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 00:12:22 INFO - 2015-11-24 00:12:22,522 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 00:12:22 INFO - 2015-11-24 00:12:22,522 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 00:12:22 INFO - 2015-11-24 00:12:22,522 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 00:12:22 INFO - 2015-11-24 00:12:22,522 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 00:12:22 INFO - 2015-11-24 00:12:22,522 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 00:12:22 INFO - 2015-11-24 00:12:22,522 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 00:12:22 INFO - 2015-11-24 00:12:22,522 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 00:12:22 INFO - 2015-11-24 00:12:22,522 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 00:12:22 INFO - 2015-11-24 00:12:22,522 DEBUG : BROWSER_OUTPUT: 00:12:23 INFO - 2015-11-24 00:12:23,038 INFO : Browser initialized. 00:12:23 INFO - 2015-11-24 00:12:23,038 INFO : Running cycle 1/1 for kraken test... 00:12:23 INFO - 2015-11-24 00:12:23,038 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/tmpjyx_09/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 00:12:34 INFO - 2015-11-24 00:12:34,834 DEBUG : BROWSER_OUTPUT: RSS: Main: 225595392 00:12:34 INFO - 2015-11-24 00:12:34,835 DEBUG : BROWSER_OUTPUT: 00:12:37 INFO - 2015-11-24 00:12:37,322 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 00:12:37 INFO - 2015-11-24 00:12:37,922 DEBUG : BROWSER_OUTPUT: RSS: Main: 276430848 00:12:37 INFO - 2015-11-24 00:12:37,922 DEBUG : BROWSER_OUTPUT: 00:12:40 INFO - 2015-11-24 00:12:40,480 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 00:12:41 INFO - 2015-11-24 00:12:41,074 DEBUG : BROWSER_OUTPUT: RSS: Main: 290922496 00:12:41 INFO - 2015-11-24 00:12:41,074 DEBUG : BROWSER_OUTPUT: 00:12:44 INFO - 2015-11-24 00:12:44,261 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 00:12:44 INFO - 2015-11-24 00:12:44,840 DEBUG : BROWSER_OUTPUT: RSS: Main: 274419712 00:12:44 INFO - 2015-11-24 00:12:44,840 DEBUG : BROWSER_OUTPUT: 00:12:46 INFO - 2015-11-24 00:12:46,668 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 00:12:47 INFO - 2015-11-24 00:12:47,256 DEBUG : BROWSER_OUTPUT: RSS: Main: 276430848 00:12:47 INFO - 2015-11-24 00:12:47,256 DEBUG : BROWSER_OUTPUT: 00:12:49 INFO - 2015-11-24 00:12:49,238 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:12:49 INFO - 2015-11-24 00:12:49,815 DEBUG : BROWSER_OUTPUT: RSS: Main: 279461888 00:12:49 INFO - 2015-11-24 00:12:49,815 DEBUG : BROWSER_OUTPUT: 00:12:52 INFO - 2015-11-24 00:12:52,443 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 00:12:53 INFO - 2015-11-24 00:12:53,029 DEBUG : BROWSER_OUTPUT: RSS: Main: 278859776 00:12:53 INFO - 2015-11-24 00:12:53,029 DEBUG : BROWSER_OUTPUT: 00:12:55 INFO - 2015-11-24 00:12:55,766 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 00:12:56 INFO - 2015-11-24 00:12:56,358 DEBUG : BROWSER_OUTPUT: RSS: Main: 280924160 00:12:56 INFO - 2015-11-24 00:12:56,358 DEBUG : BROWSER_OUTPUT: 00:12:59 INFO - 2015-11-24 00:12:59,006 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 00:12:59 INFO - 2015-11-24 00:12:59,596 DEBUG : BROWSER_OUTPUT: RSS: Main: 280985600 00:12:59 INFO - 2015-11-24 00:12:59,597 DEBUG : BROWSER_OUTPUT: 00:13:01 INFO - 2015-11-24 00:13:01,119 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:13:01 INFO - 2015-11-24 00:13:01,696 DEBUG : BROWSER_OUTPUT: RSS: Main: 314593280 00:13:01 INFO - 2015-11-24 00:13:01,696 DEBUG : BROWSER_OUTPUT: 00:13:03 INFO - 2015-11-24 00:13:03,593 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:13:04 INFO - 2015-11-24 00:13:04,204 DEBUG : BROWSER_OUTPUT: RSS: Main: 315400192 00:13:04 INFO - 2015-11-24 00:13:04,204 DEBUG : BROWSER_OUTPUT: 00:13:06 INFO - 2015-11-24 00:13:06,250 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:13:06 INFO - 2015-11-24 00:13:06,847 DEBUG : BROWSER_OUTPUT: RSS: Main: 323309568 00:13:06 INFO - 2015-11-24 00:13:06,847 DEBUG : BROWSER_OUTPUT: 00:13:09 INFO - 2015-11-24 00:13:09,432 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:13:10 INFO - 2015-11-24 00:13:10,057 DEBUG : BROWSER_OUTPUT: RSS: Main: 324374528 00:13:10 INFO - 2015-11-24 00:13:10,057 DEBUG : BROWSER_OUTPUT: 00:13:12 INFO - 2015-11-24 00:13:12,471 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:13:13 INFO - 2015-11-24 00:13:13,056 DEBUG : BROWSER_OUTPUT: RSS: Main: 325054464 00:13:13 INFO - 2015-11-24 00:13:13,056 DEBUG : BROWSER_OUTPUT: 00:13:14 INFO - 2015-11-24 00:13:14,713 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 00:13:14 INFO - 2015-11-24 00:13:14,955 DEBUG : BROWSER_OUTPUT: RSS: Main: 383954944 00:13:14 INFO - 2015-11-24 00:13:14,955 DEBUG : BROWSER_OUTPUT: 00:13:14 INFO - 2015-11-24 00:13:14,958 DEBUG : BROWSER_OUTPUT: __start_tp_report 00:13:14 INFO - 2015-11-24 00:13:14,958 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 00:13:14 INFO - 2015-11-24 00:13:14,959 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 00:13:14 INFO - 2015-11-24 00:13:14,959 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 00:13:14 INFO - 2015-11-24 00:13:14,959 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;110;104;109;110;110;108;109;100;108 00:13:14 INFO - 2015-11-24 00:13:14,959 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;147;120;142;153;118;140;138;118;156;138 00:13:14 INFO - 2015-11-24 00:13:14,959 DEBUG : BROWSER_OUTPUT: |2;audio-dft;183;182;181;183;184;183;183;184;187;182 00:13:14 INFO - 2015-11-24 00:13:14,959 DEBUG : BROWSER_OUTPUT: |3;audio-fft;60;70;74;73;54;56;56;69;72;54 00:13:14 INFO - 2015-11-24 00:13:14,959 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;83;86;112;74;77;74;106;70;74;105 00:13:14 INFO - 2015-11-24 00:13:14,959 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;84;85;84;84;86;85;85;88;84;83 00:13:14 INFO - 2015-11-24 00:13:14,959 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;92;92;92;92;92;92;93;91;92;92 00:13:14 INFO - 2015-11-24 00:13:14,959 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;84;85;83;84;87;87;86;84;85;86 00:13:14 INFO - 2015-11-24 00:13:14,959 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;55;55;54;55;54;53;61;51;51 00:13:14 INFO - 2015-11-24 00:13:14,959 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;62;63;65;95;97;97;66;68;67 00:13:14 INFO - 2015-11-24 00:13:14,960 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;83;83;76;83;82;81;84;84;83 00:13:14 INFO - 2015-11-24 00:13:14,960 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;126;127;121;127;115;134;121;122;126;135 00:13:14 INFO - 2015-11-24 00:13:14,960 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;134;135;132;134;134;134;135;133;131;123 00:13:14 INFO - 2015-11-24 00:13:14,960 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;63;63;65;64;65;64;63;65;65;65 00:13:14 INFO - 2015-11-24 00:13:14,960 DEBUG : BROWSER_OUTPUT: __end_tp_report 00:13:14 INFO - 2015-11-24 00:13:14,960 DEBUG : BROWSER_OUTPUT: __start_cc_report 00:13:14 INFO - 2015-11-24 00:13:14,960 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1046 00:13:14 INFO - 2015-11-24 00:13:14,960 DEBUG : BROWSER_OUTPUT: __end_cc_report 00:13:14 INFO - 2015-11-24 00:13:14,960 DEBUG : BROWSER_OUTPUT: __startTimestamp1448352794957__endTimestamp 00:13:14 INFO - 2015-11-24 00:13:14,960 DEBUG : BROWSER_OUTPUT: 00:13:14 INFO - 2015-11-24 00:13:14,967 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 00:13:14 INFO - 2015-11-24 00:13:14,968 DEBUG : BROWSER_OUTPUT: Number of tests: 14 00:13:14 INFO - 2015-11-24 00:13:14,968 DEBUG : BROWSER_OUTPUT: 00:13:14 INFO - 2015-11-24 00:13:14,968 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.60 Median:109.00 stddev:3.20 (2.9%) stddev-sans-first:3.40 00:13:14 INFO - 2015-11-24 00:13:14,968 DEBUG : BROWSER_OUTPUT: Values: 108.0 110.0 104.0 109.0 110.0 110.0 108.0 109.0 100.0 108.0 00:13:14 INFO - 2015-11-24 00:13:14,968 DEBUG : BROWSER_OUTPUT: 00:13:14 INFO - 2015-11-24 00:13:14,968 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:137.00 Median:141.00 stddev:14.00 (9.9%) stddev-sans-first:14.37 00:13:14 INFO - 2015-11-24 00:13:14,968 DEBUG : BROWSER_OUTPUT: Values: 147.0 120.0 142.0 153.0 118.0 140.0 138.0 118.0 156.0 138.0 00:13:14 INFO - 2015-11-24 00:13:14,968 DEBUG : BROWSER_OUTPUT: 00:13:14 INFO - 2015-11-24 00:13:14,968 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:183.20 Median:183.00 stddev:1.62 (0.9%) stddev-sans-first:1.72 00:13:14 INFO - 2015-11-24 00:13:14,968 DEBUG : BROWSER_OUTPUT: Values: 183.0 182.0 181.0 183.0 184.0 183.0 183.0 184.0 187.0 182.0 00:13:14 INFO - 2015-11-24 00:13:14,968 DEBUG : BROWSER_OUTPUT: 00:13:14 INFO - 2015-11-24 00:13:14,968 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:63.80 Median:69.50 stddev:8.50 (12.2%) stddev-sans-first:8.90 00:13:14 INFO - 2015-11-24 00:13:14,969 DEBUG : BROWSER_OUTPUT: Values: 60.0 70.0 74.0 73.0 54.0 56.0 56.0 69.0 72.0 54.0 00:13:14 INFO - 2015-11-24 00:13:14,969 DEBUG : BROWSER_OUTPUT: 00:13:14 INFO - 2015-11-24 00:13:14,969 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:86.10 Median:74.00 stddev:15.69 (21.2%) stddev-sans-first:16.60 00:13:14 INFO - 2015-11-24 00:13:14,969 DEBUG : BROWSER_OUTPUT: Values: 83.0 86.0 112.0 74.0 77.0 74.0 106.0 70.0 74.0 105.0 00:13:14 INFO - 2015-11-24 00:13:14,969 DEBUG : BROWSER_OUTPUT: 00:13:14 INFO - 2015-11-24 00:13:14,969 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:84.80 Median:85.00 stddev:1.40 (1.6%) stddev-sans-first:1.45 00:13:14 INFO - 2015-11-24 00:13:14,969 DEBUG : BROWSER_OUTPUT: Values: 84.0 85.0 84.0 84.0 86.0 85.0 85.0 88.0 84.0 83.0 00:13:14 INFO - 2015-11-24 00:13:14,969 DEBUG : BROWSER_OUTPUT: 00:13:14 INFO - 2015-11-24 00:13:14,969 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:92.00 Median:92.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 00:13:14 INFO - 2015-11-24 00:13:14,969 DEBUG : BROWSER_OUTPUT: Values: 92.0 92.0 92.0 92.0 92.0 92.0 93.0 91.0 92.0 92.0 00:13:14 INFO - 2015-11-24 00:13:14,969 DEBUG : BROWSER_OUTPUT: 00:13:14 INFO - 2015-11-24 00:13:14,969 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:85.10 Median:85.50 stddev:1.37 (1.6%) stddev-sans-first:1.39 00:13:14 INFO - 2015-11-24 00:13:14,969 DEBUG : BROWSER_OUTPUT: Values: 84.0 85.0 83.0 84.0 87.0 87.0 86.0 84.0 85.0 86.0 00:13:14 INFO - 2015-11-24 00:13:14,970 DEBUG : BROWSER_OUTPUT: 00:13:14 INFO - 2015-11-24 00:13:14,970 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:54.60 Median:55.00 stddev:2.91 (5.3%) stddev-sans-first:2.96 00:13:14 INFO - 2015-11-24 00:13:14,970 DEBUG : BROWSER_OUTPUT: Values: 57.0 55.0 55.0 54.0 55.0 54.0 53.0 61.0 51.0 51.0 00:13:14 INFO - 2015-11-24 00:13:14,970 DEBUG : BROWSER_OUTPUT: 00:13:14 INFO - 2015-11-24 00:13:14,970 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:74.30 Median:67.50 stddev:15.33 (22.7%) stddev-sans-first:15.70 00:13:14 INFO - 2015-11-24 00:13:14,970 DEBUG : BROWSER_OUTPUT: Values: 63.0 62.0 63.0 65.0 95.0 97.0 97.0 66.0 68.0 67.0 00:13:14 INFO - 2015-11-24 00:13:14,970 DEBUG : BROWSER_OUTPUT: 00:13:14 INFO - 2015-11-24 00:13:14,970 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:83.00 stddev:2.33 (2.8%) stddev-sans-first:2.47 00:13:14 INFO - 2015-11-24 00:13:14,970 DEBUG : BROWSER_OUTPUT: Values: 82.0 83.0 83.0 76.0 83.0 82.0 81.0 84.0 84.0 83.0 00:13:14 INFO - 2015-11-24 00:13:14,970 DEBUG : BROWSER_OUTPUT: 00:13:14 INFO - 2015-11-24 00:13:14,970 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.40 Median:126.50 stddev:6.06 (4.8%) stddev-sans-first:6.42 00:13:14 INFO - 2015-11-24 00:13:14,970 DEBUG : BROWSER_OUTPUT: Values: 126.0 127.0 121.0 127.0 115.0 134.0 121.0 122.0 126.0 135.0 00:13:14 INFO - 2015-11-24 00:13:14,970 DEBUG : BROWSER_OUTPUT: 00:13:14 INFO - 2015-11-24 00:13:14,971 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:132.50 Median:134.00 stddev:3.57 (2.7%) stddev-sans-first:3.74 00:13:14 INFO - 2015-11-24 00:13:14,971 DEBUG : BROWSER_OUTPUT: Values: 134.0 135.0 132.0 134.0 134.0 134.0 135.0 133.0 131.0 123.0 00:13:14 INFO - 2015-11-24 00:13:14,971 DEBUG : BROWSER_OUTPUT: 00:13:14 INFO - 2015-11-24 00:13:14,971 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:65.00 stddev:0.92 (1.4%) stddev-sans-first:0.87 00:13:14 INFO - 2015-11-24 00:13:14,971 DEBUG : BROWSER_OUTPUT: Values: 63.0 63.0 65.0 64.0 65.0 64.0 63.0 65.0 65.0 65.0 00:13:14 INFO - 2015-11-24 00:13:14,971 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 00:13:14 INFO - 2015-11-24 00:13:14,971 DEBUG : BROWSER_OUTPUT: 00:13:15 INFO - 2015-11-24 00:13:15,738 INFO : Browser exited with error code: 0 00:13:15 INFO - 2015-11-24 00:13:15,783 INFO : Completed test kraken (00:00:55) 00:13:15 INFO - 2015-11-24 00:13:15,784 INFO : Starting test v8_7 00:13:15 INFO - 2015-11-24 00:13:15,784 DEBUG : operating with platform_type : mac_ 00:13:15 INFO - 2015-11-24 00:13:15,784 INFO : Initialising browser for v8_7 test... 00:13:15 INFO - 2015-11-24 00:13:15,796 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/tmpQm0IRk/profile http://localhost:49271/getInfo.html 00:13:17 INFO - 2015-11-24 00:13:17,918 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 00:13:17 INFO - 2015-11-24 00:13:17,918 DEBUG : BROWSER_OUTPUT: colorDepth:24 00:13:17 INFO - 2015-11-24 00:13:17,918 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 00:13:17 INFO - 2015-11-24 00:13:17,918 DEBUG : BROWSER_OUTPUT: __metrics 00:13:17 INFO - 2015-11-24 00:13:17,934 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:13:18 INFO - 2015-11-24 00:13:18,174 DEBUG : BROWSER_OUTPUT: console.error: 00:13:18 INFO - 2015-11-24 00:13:18,174 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 00:13:18 INFO - 2015-11-24 00:13:18,174 DEBUG : BROWSER_OUTPUT: Stack: 00:13:18 INFO - 2015-11-24 00:13:18,174 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 00:13:18 INFO - 2015-11-24 00:13:18,175 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 00:13:18 INFO - 2015-11-24 00:13:18,175 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 00:13:18 INFO - 2015-11-24 00:13:18,175 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 00:13:18 INFO - 2015-11-24 00:13:18,175 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 00:13:18 INFO - 2015-11-24 00:13:18,175 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 00:13:18 INFO - 2015-11-24 00:13:18,175 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 00:13:18 INFO - 2015-11-24 00:13:18,175 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 00:13:18 INFO - 2015-11-24 00:13:18,175 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 00:13:18 INFO - 2015-11-24 00:13:18,175 DEBUG : BROWSER_OUTPUT: 00:13:18 INFO - 2015-11-24 00:13:18,552 INFO : Browser initialized. 00:13:18 INFO - 2015-11-24 00:13:18,552 INFO : Running cycle 1/1 for v8_7 test... 00:13:18 INFO - 2015-11-24 00:13:18,552 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/tmpQm0IRk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 00:13:30 INFO - 2015-11-24 00:13:30,471 DEBUG : BROWSER_OUTPUT: RSS: Main: 226316288 00:13:30 INFO - 2015-11-24 00:13:30,471 DEBUG : BROWSER_OUTPUT: 00:13:51 INFO - 2015-11-24 00:13:51,920 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/v8_7/run.html (next: http://localhost:49271/tests/v8_7/run.html) 00:13:52 INFO - 2015-11-24 00:13:52,177 DEBUG : BROWSER_OUTPUT: RSS: Main: 687575040 00:13:52 INFO - 2015-11-24 00:13:52,177 DEBUG : BROWSER_OUTPUT: 00:13:52 INFO - 2015-11-24 00:13:52,177 DEBUG : BROWSER_OUTPUT: __start_tp_report 00:13:52 INFO - 2015-11-24 00:13:52,177 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 00:13:52 INFO - 2015-11-24 00:13:52,177 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 00:13:52 INFO - 2015-11-24 00:13:52,177 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 00:13:52 INFO - 2015-11-24 00:13:52,177 DEBUG : BROWSER_OUTPUT: |0;Richards;173.28019407381737 00:13:52 INFO - 2015-11-24 00:13:52,178 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;161.53970043485262 00:13:52 INFO - 2015-11-24 00:13:52,178 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.1641168289291 00:13:52 INFO - 2015-11-24 00:13:52,178 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4643.518518518518 00:13:52 INFO - 2015-11-24 00:13:52,178 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1730.1038062283737 00:13:52 INFO - 2015-11-24 00:13:52,178 DEBUG : BROWSER_OUTPUT: |5;Earley;787.4015748031496 00:13:52 INFO - 2015-11-24 00:13:52,178 DEBUG : BROWSER_OUTPUT: |6;Boyer;12444.444444444445 00:13:52 INFO - 2015-11-24 00:13:52,178 DEBUG : BROWSER_OUTPUT: |7;RegExp;28828.571428571428 00:13:52 INFO - 2015-11-24 00:13:52,178 DEBUG : BROWSER_OUTPUT: |8;Splay;656.1679790026246 00:13:52 INFO - 2015-11-24 00:13:52,178 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4468.75 00:13:52 INFO - 2015-11-24 00:13:52,178 DEBUG : BROWSER_OUTPUT: __end_tp_report 00:13:52 INFO - 2015-11-24 00:13:52,178 DEBUG : BROWSER_OUTPUT: __startTimestamp1448352832171__endTimestamp 00:13:52 INFO - 2015-11-24 00:13:52,178 DEBUG : BROWSER_OUTPUT: 00:13:52 INFO - 2015-11-24 00:13:52,178 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 00:13:52 INFO - 2015-11-24 00:13:52,178 DEBUG : BROWSER_OUTPUT: Number of tests: 10 00:13:52 INFO - 2015-11-24 00:13:52,179 DEBUG : BROWSER_OUTPUT: 00:13:52 INFO - 2015-11-24 00:13:52,179 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:173.28 Median:173.28 stddev:0.00 (0.0%) 00:13:52 INFO - 2015-11-24 00:13:52,179 DEBUG : BROWSER_OUTPUT: Values: 173.3 00:13:52 INFO - 2015-11-24 00:13:52,179 DEBUG : BROWSER_OUTPUT: 00:13:52 INFO - 2015-11-24 00:13:52,179 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:161.54 Median:161.54 stddev:0.00 (0.0%) 00:13:52 INFO - 2015-11-24 00:13:52,179 DEBUG : BROWSER_OUTPUT: Values: 161.5 00:13:52 INFO - 2015-11-24 00:13:52,179 DEBUG : BROWSER_OUTPUT: 00:13:52 INFO - 2015-11-24 00:13:52,179 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.16 Median:278.16 stddev:0.00 (0.0%) 00:13:52 INFO - 2015-11-24 00:13:52,179 DEBUG : BROWSER_OUTPUT: Values: 278.2 00:13:52 INFO - 2015-11-24 00:13:52,179 DEBUG : BROWSER_OUTPUT: 00:13:52 INFO - 2015-11-24 00:13:52,179 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4643.52 Median:4643.52 stddev:0.00 (0.0%) 00:13:52 INFO - 2015-11-24 00:13:52,179 DEBUG : BROWSER_OUTPUT: Values: 4643.5 00:13:52 INFO - 2015-11-24 00:13:52,179 DEBUG : BROWSER_OUTPUT: 00:13:52 INFO - 2015-11-24 00:13:52,179 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1730.10 Median:1730.10 stddev:0.00 (0.0%) 00:13:52 INFO - 2015-11-24 00:13:52,179 DEBUG : BROWSER_OUTPUT: Values: 1730.1 00:13:52 INFO - 2015-11-24 00:13:52,180 DEBUG : BROWSER_OUTPUT: 00:13:52 INFO - 2015-11-24 00:13:52,180 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:787.40 Median:787.40 stddev:0.00 (0.0%) 00:13:52 INFO - 2015-11-24 00:13:52,180 DEBUG : BROWSER_OUTPUT: Values: 787.4 00:13:52 INFO - 2015-11-24 00:13:52,180 DEBUG : BROWSER_OUTPUT: 00:13:52 INFO - 2015-11-24 00:13:52,180 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12444.44 Median:12444.44 stddev:0.00 (0.0%) 00:13:52 INFO - 2015-11-24 00:13:52,180 DEBUG : BROWSER_OUTPUT: Values: 12444.4 00:13:52 INFO - 2015-11-24 00:13:52,180 DEBUG : BROWSER_OUTPUT: 00:13:52 INFO - 2015-11-24 00:13:52,180 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:28828.57 Median:28828.57 stddev:0.00 (0.0%) 00:13:52 INFO - 2015-11-24 00:13:52,180 DEBUG : BROWSER_OUTPUT: Values: 28828.6 00:13:52 INFO - 2015-11-24 00:13:52,180 DEBUG : BROWSER_OUTPUT: 00:13:52 INFO - 2015-11-24 00:13:52,180 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:656.17 Median:656.17 stddev:0.00 (0.0%) 00:13:52 INFO - 2015-11-24 00:13:52,180 DEBUG : BROWSER_OUTPUT: Values: 656.2 00:13:52 INFO - 2015-11-24 00:13:52,180 DEBUG : BROWSER_OUTPUT: 00:13:52 INFO - 2015-11-24 00:13:52,180 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4468.75 Median:4468.75 stddev:0.00 (0.0%) 00:13:52 INFO - 2015-11-24 00:13:52,180 DEBUG : BROWSER_OUTPUT: Values: 4468.8 00:13:52 INFO - 2015-11-24 00:13:52,181 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 00:13:52 INFO - 2015-11-24 00:13:52,181 DEBUG : BROWSER_OUTPUT: 00:13:52 INFO - 2015-11-24 00:13:52,778 INFO : Browser exited with error code: 0 00:13:52 INFO - 2015-11-24 00:13:52,796 INFO : Completed test v8_7 (00:00:37) 00:13:53 INFO - 2015-11-24 00:13:53,219 INFO : Completed test suite (00:20:06) 00:13:53 INFO - 2015-11-24 00:13:53,219 DEBUG : Working with test: dromaeo_css 00:13:53 INFO - 2015-11-24 00:13:53,219 DEBUG : Generating results file: dromaeo_css 00:13:53 INFO - 2015-11-24 00:13:53,220 DEBUG : Working with test: kraken 00:13:53 INFO - 2015-11-24 00:13:53,220 DEBUG : Generating results file: kraken 00:13:53 INFO - 2015-11-24 00:13:53,220 INFO : javascript benchmark 00:13:53 INFO - 2015-11-24 00:13:53,220 DEBUG : Working with test: v8_7 00:13:53 INFO - 2015-11-24 00:13:53,220 DEBUG : Generating results file: v8_7 00:13:53 INFO - 2015-11-24 00:13:53,220 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:13:53 INFO - 2015-11-24 00:13:53,287 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 00:13:53 INFO - 2015-11-24 00:13:53,287 DEBUG : process_Request line: dromaeo_css 7701.83 graph.html#tests=[[72,64,59]] 00:13:53 INFO - 2015-11-24 00:13:53,287 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:13:53 INFO - 2015-11-24 00:13:53,389 DEBUG : process_Request line: kraken 1372.70 graph.html#tests=[[232,64,59]] 00:13:53 INFO - 2015-11-24 00:13:53,389 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:13:53 INFO - 2015-11-24 00:13:53,416 DEBUG : process_Request line: v8_7 20326.28 graph.html#tests=[[230,64,59]] 00:13:53 INFO - 2015-11-24 00:13:53,417 INFO : javascript benchmark 00:13:53 INFO - 2015-11-24 00:13:53,419 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3383.3064221834525, 3454.6545345465474, 3497.352989696906, 3507.5790905091394, 3535.4166562517194, 5697.4302569743, 5840.153177789218, 5863.472287494124, 5870.090136028912, 5880.794172203969, 4927.2855435961765, 5798.710064496769, 5801.216835727176, 5917.408259174081, 5925.762969481227, 5152.639315247934, 5170.172772356424, 5170.638055336128, 5175.5600773934075, 5249.737513124348, 4767.65868576118, 5311.990721762872, 5358.571314294847, 5374.435684253156, 5396.892062158754, 5122.359705036871, 5174.896502069938, 5186.325777648919, 5301.655392399501, 5311.9468805311835, 5239.659422137549, 5262.05283049051, 5263.184206448007, 5267.47325267474, 5272.051030814452, 5137.7944882204665, 5183.688978661293, 5221.6083793715625, 5230.895382092337, 5241.8165364212455, 5689.487946084831, 5739.942600574024, 5743.741531631086, 5745.0, 5750.511206547449, 6308.526860485482, 6322.083297921776, 6324.7470101195895, 6334.398232167937, 6341.936580634227, 6152.753889844401, 6191.87616247677, 6233.407826256498, 6283.246010478726, 6296.150019747367, 5896.587238893237, 5960.5827592068135, 5970.432808883149, 5974.0, 6012.518998480111, 6296.622202667763, 6347.587406818542, 6353.61878287295, 6356.269029061625, 6370.713317900706, 5138.460461651547, 6068.393160683984, 6121.544430002081, 6134.6625935573975, 6241.563090583615, 6314.0, 6315.273743519462, 6324.3991820776955, 6333.588316759396, 6334.049892516067, 6271.592346497463, 6288.968555157195, 6295.874082518416, 6302.968485157545, 6309.211348581427, 6096.774513597423, 6161.630302181883, 6184.536159787944, 6227.9377206227355, 6273.341299163522, 4956.826511072095, 4997.625178111583, 5009.198528235464, 5010.3737032870895, 5034.446210916796, 4477.082198149372, 4483.314935892001, 4484.080763443486, 4522.072975040109, 4543.182227199136, 5627.155926610959, 5685.829425117253, 5699.943000570024, 5752.971235143881, 5776.682282474504, 5349.919751203735, 6222.595531290452, 6264.21697287839, 6267.1539342189135, 6297.4962003039645, 5746.942530574641, 5750.6262092963825, 5761.8559536011935, 5763.9135412968835, 5787.305523337226, 5289.285946397187, 5396.9730151348995, 5407.621466497386, 5421.647592906448, 5431.4840090191365, 6156.26124865019, 6267.341929097379, 6287.056941458726, 6291.339409362043, 6317.273513546001, 6265.091561723616, 6293.150424692608, 6297.1813664223355, 6304.905426418699, 6306.621602703853, 6318.0, 6386.616802991835, 6395.392437718409, 6403.64779937108, 6407.711652975534, 6095.939040609537, 6165.383461653799, 6176.7838125665385, 6184.0, 6278.529110316653, 6154.476869466145, 6272.529560283088, 6283.3402492737605, 6285.622862628257, 6294.496440284858, 6140.846478838065, 6154.323024467394, 6180.536459765445, 6189.412005859616, 6207.565470417027, 6004.669743164168, 6180.783672571439, 6191.535634827316, 6192.0, 6192.318844926965, 5734.9390362783015, 5845.912311315248, 5863.618864773776, 5868.383819699041, 5872.882542349214, 5689.032864412977, 5728.825590753802, 6154.78458253959, 6170.6914654268, 6185.659788711664, 5274.103402421674, 5985.940140598538, 6027.057812593806, 6059.33347331802, 6083.270007599116], "unit": "ms", "name": "dojo.html", "value": 5727.63434562296}, {"lowerIsBetter": false, "replicates": [556.9804386938713, 571.9885602287954, 576.5790972590006, 580.2340909998803, 604.8447465341197, 32147.03558893234, 32445.351092978126, 32460.837695811548, 32534.0239792806, 32560.0, 40030.59969400305, 40559.79720101403, 40591.0, 40616.78149655515, 40643.796781016055, 9784.608615655383, 9967.352122112075, 9975.152112070482, 9975.351602145873, 10021.949890250575, 8799.692010779623, 8925.330600204978, 8940.821183576325, 9750.268729845255, 9874.506274686273, 11895.226810257349, 12037.337946412943, 12048.57829975951, 12062.095342849278, 12079.516819327217, 11663.650090497256, 11726.530938762438, 11738.0, 11747.0, 11757.823632645517, 8842.867356989651, 8943.55282235892, 8952.0, 11737.413129343498, 11757.941210293979, 41020.974475638046, 41320.586794131974, 41385.965350866165, 41419.0, 41449.79275103635, 3194.3291908699202, 3270.73834093272, 3282.655321191264, 3318.6183588887347, 3617.8733744319084, 28389.116660454714, 28789.856050719824, 29215.41569168605, 29245.268868278465, 29303.87599216728, 2712.755851973312, 2803.8457884816326, 2852.443773464175, 2923.605313282701, 2989.491786396318, 495882.0, 501241.99999999633, 503243.0, 505542.0, 508557.0, 64626.353736462035, 64915.0, 64990.025149622794, 65078.34921650818, 65176.67411662911, 67261.6547669044, 67329.3267067323, 67425.3257467419, 67551.66224168848, 67561.32438675649, 15857.444989425314, 16240.431584894472, 16252.0, 16261.430849920196, 16266.51200463988, 12349.3825308736, 12400.379981000913, 12407.828629989715, 12410.627681169579, 12430.689232769253, 19226.423207303804, 19734.013299334976, 19781.60436791256, 19799.802001979795, 19834.20663173457, 8993.775155621162, 9188.724338269863, 9190.862137067948, 9196.770080747901, 9237.630494780133, 940.5438362394233, 963.6386355116831, 964.6671898195111, 985.0, 1095.7315457712912, 29424.411511769646, 29531.114066578037, 29954.40091198164, 30007.399852002836, 30118.397632047676, 892.9374044886564, 1089.3844977587637, 1091.1380009792333, 1165.5862168930078, 1251.499400239893, 14560.0, 14717.44435112332, 14766.966312358247, 14874.405023799143, 14902.850971490363, 542470.0, 545469.0, 545485.0, 704824.0, 705435.0, 46414.0, 56967.43032569704, 57704.0, 57940.42059579435, 58052.09739513092, 1329.6808765896308, 1331.7003674173427, 1424.480064776349, 1438.467766926223, 1447.1100273332036, 26172.0, 28793.42413151767, 29620.703792961795, 29894.0, 30305.69694303029, 55340.44659553353, 55614.72192639173, 55759.0, 55775.0, 55873.72063139658, 465760.0, 467413.0, 468594.0, 469269.0, 470726.0, 30434.39131217319, 31527.84236078805, 31546.684533154374, 31560.42373855824, 31560.52659210068, 44725.776371117936, 45141.32288015616, 45141.32288015616, 45273.32090018586, 45855.85360366017, 35424.645753542136, 36713.0, 37522.0, 37743.62256377401, 38315.0, 36588.0, 36963.63036369602, 37086.0, 37410.62589374071, 37675.0, 34484.65515344815, 35342.0, 35521.0, 35570.822145889106, 35594.82202589074, 30545.0, 31040.53439198459, 31377.68622313839, 31537.526937095503, 31623.84188079045, 21202.15191392327, 22372.105115795835, 24099.51800963936, 24219.546827190425, 24683.113463019694], "unit": "ms", "name": "ext.html", "value": 20064.5799081633}, {"lowerIsBetter": false, "replicates": [341.7866573663494, 347.272464187527, 366.543653151826, 369.73563901810206, 373.32241980804855, 16180.110093944828, 16216.594585135377, 19476.90261548692, 20118.09468573914, 20867.0, 14920.626984325398, 19281.61436771264, 19635.705464418046, 19938.900305498453, 19951.30170444031, 5741.224934633834, 5913.497352725023, 5947.286325640907, 6588.934110658904, 6765.729370825161, 4005.1388951375448, 4123.092919557693, 4135.35901935199, 4398.73607583546, 5869.941300587004, 5995.760169593211, 5996.040633498641, 6014.5188384929315, 6018.7893423730175, 6025.638461692312, 5823.737931793058, 6014.518838492954, 6018.729157187937, 6025.3372129065765, 6039.969800150993, 5636.251023955542, 5677.120046392815, 5728.283964504437, 5732.111522713986, 5750.079987202028, 24057.75942240573, 24597.877010614833, 24879.87560062206, 25030.37424064395, 25979.830907609015, 2011.9798802012085, 2035.0842121045441, 2044.621744977169, 2070.2960993262213, 2103.747550293959, 9726.805463890683, 10095.697129086138, 11313.434328283634, 15362.0, 15524.844751552566, 1812.3837895115591, 1819.9909000455045, 1834.477174005402, 1869.401791426744, 1908.1985566062149, 89379.0, 113704.0, 114071.99999999917, 115242.27136592958, 116419.0, 19338.4198474046, 19467.318643847397, 19606.411807645793, 19642.60714785696, 19670.508237294183, 29071.709282907323, 29099.12702618925, 29119.0, 29136.41727165445, 29153.85423072871, 10368.170546356274, 10371.429571373495, 10386.792264154827, 10408.970250801021, 10451.268411211142, 8762.036176020632, 8815.911840881638, 8840.62970239614, 8846.894138232721, 8909.73270801864, 8860.0, 8887.0, 8892.377533572588, 8939.016708162097, 8941.37410381267, 2973.3012742005612, 3452.5166476693284, 3503.597086335053, 3516.367053930317, 3568.13104988831, 827.3960009193322, 845.945013574128, 914.291424146292, 988.619381538113, 997.9800403991879, 19831.504212394804, 20175.0, 20489.385318440174, 21118.0, 21339.35981920545, 812.427238796647, 877.2499512916493, 914.9542522873962, 918.6555041859302, 995.3665686230609, 8583.699570515002, 9899.950500247596, 10476.266661333786, 10489.160867130611, 10518.0, 765385.1730741422, 785545.072274635, 792077.0, 792813.0, 798963.0, 90927.54536227277, 110662.0, 115427.0, 115984.0, 123058.0, 977.9559919803626, 1169.3977601535216, 1173.8239264110452, 1175.9706007349714, 1184.265755231762, 18028.729569056737, 18205.908970455064, 18245.54386140357, 18300.633987319914, 18520.536986575444, 53523.732381337846, 53831.19253211284, 55974.44025559692, 57946.4205357941, 58159.0, 72872.27127728655, 72936.27063729506, 73017.6349118251, 75175.24824751682, 75201.6239918797, 9755.756106097404, 9848.458334791656, 10018.148457381205, 10037.548310325907, 10048.849267261143, 11965.282083075042, 11992.460339284578, 12062.0, 12083.033357331567, 18933.526661833563, 16106.215039465482, 16115.113668748332, 16375.181240938144, 16592.668146637243, 16608.00351978885, 15536.844631553991, 15743.0, 15904.966177198445, 15987.8401215991, 16137.273822677773, 15931.601709957344, 16490.58773530671, 16507.58731031734, 16517.33930642761, 17123.97256164634, 9622.0, 9661.372010819274, 9767.316287860065, 9771.706848794547, 9788.657396991355, 14137.43450261978, 15674.843251567338, 15795.052296862224, 16205.837941620433, 16387.83612163863], "unit": "ms", "name": "jquery.html", "value": 10805.960516763735}, {"lowerIsBetter": false, "replicates": [1593.3387644127688, 1595.7845690831734, 1856.9442916712496, 1871.8876867387953, 1895.5829717462154, 8415.0, 8599.78500537486, 8607.440516366432, 8614.52620105894, 8629.956850215756, 8421.91578084219, 8436.156384361577, 8442.704505342313, 8448.788780280496, 8452.535110568917, 2329.0683726509365, 2362.137819695807, 2375.2161786610463, 2375.7861792438675, 2383.2254517281867, 2368.786809187173, 2399.328188107324, 2412.107520217522, 2415.2029830156007, 2416.0, 2125.3517677108475, 2166.750823655284, 2176.260071575664, 2374.41826752445, 2385.8568485890814, 1977.5253939054596, 2315.409570559505, 2336.4509340305017, 2356.658284548748, 2360.5514952159033, 2344.191254017361, 2392.3899405651623, 2400.867952262625, 2401.0995876546294, 2407.0, 7678.769636910845, 7884.250996155413, 8277.875831862466, 8414.200650938152, 8493.617787199591, 5090.261912022773, 5174.637775355689, 5181.4041385240425, 5188.507091826271, 5192.299039629639, 3492.1618811485314, 3566.465030245458, 3613.403788374915, 3637.345277849986, 3641.9453708194396, 1058.185197398007, 1062.3519653011733, 1065.579096256982, 1079.9730006749814, 1081.4481219450035, 10997.955194256532, 11080.002799748061, 11088.0, 11102.944485277603, 11128.944355278252, 4651.139539185261, 4682.601978831769, 4719.811207551728, 4735.479097299294, 4749.62003039756, 9739.0, 9748.220142388593, 9752.46361450127, 9767.755806104762, 9783.608655653694, 5209.453007434241, 5218.269442278084, 5220.321358223407, 5220.425753167148, 5223.190405487156, 4698.248280275139, 4743.146233677971, 4744.5729884309885, 4745.786439610226, 4751.097291514601, 3633.3823250047553, 3714.647108524686, 3740.588535261119, 3745.6816170625257, 3753.774773513598, 1225.7854875396947, 1231.322772475135, 1234.0559472003924, 1234.4383305595932, 1243.639344590077, 1327.2633688303085, 1331.4873773597042, 1356.986430135686, 1364.2019418640207, 1399.9090059146122, 7757.806054848674, 7898.684052637945, 7899.249571290718, 7904.0, 7904.486208396436, 497.72127608539336, 507.42914221500814, 512.116598866959, 512.5233532814518, 514.3776031002454, 5952.642841429528, 6018.548608854353, 6183.536234782319, 6254.3745625437095, 6263.937360626426, 8662.523561204194, 9366.484843333683, 9972.152367048882, 10111.696649100539, 10243.897561024443, 9849.75375615601, 10022.498875056364, 10031.849522257173, 10108.24188185889, 10130.08829205375, 7828.647710853025, 7894.881576776353, 7976.2422569856935, 7979.3616510679, 7982.720604778805, 7170.211276759656, 7587.393008559192, 7869.409794265339, 7873.803154921173, 7893.802654933673, 8812.383133180872, 9008.684696035607, 9019.052999434965, 9040.593173307348, 9228.35401521887, 9076.455412675261, 9284.118008789153, 9394.342396032212, 9397.483138427178, 9434.85847712271, 7320.707171713285, 7328.120625524971, 7340.339369456561, 7374.225706300976, 7412.1846596875375, 7950.284474397332, 8003.5197888126895, 8015.639296231567, 8020.117787043538, 8022.9598852005365, 7404.925950740424, 7460.0301960744755, 7520.924790752022, 7637.236276372319, 7637.541747495168, 7339.522931009467, 7371.078615173104, 7438.070241219848, 7455.962720186364, 7478.588677622565, 7466.664000119899, 7518.812029699301, 7525.134609519975, 7535.773926782205, 7536.7362142324755, 6240.563160578716, 6829.6243706596615, 6872.759453419107, 6891.827704307432, 6894.931050689429, 6602.867942641216, 6635.8009259722285, 6652.866942661217, 6680.298568650416, 6695.564788288746], "unit": "ms", "name": "mootools.html", "value": 4695.546421899053}, {"lowerIsBetter": false, "replicates": [273.73721227621485, 284.86041839498654, 332.34859675036927, 337.8564110253142, 347.0888916593941, 6463.806085817427, 6599.241087274965, 6654.201495820496, 6728.125343705324, 6741.730330786762, 5295.735213239333, 6645.335466453353, 6661.63361015144, 6663.733450661967, 6670.266270710218, 4346.630536404409, 4888.584470320027, 4889.535494128052, 4902.558769710726, 4916.237983112624, 4438.911221775563, 4774.28385742138, 4854.199057155565, 4871.415430148387, 4912.140375434303, 4823.662343635947, 4834.951650483503, 4839.903201935959, 4845.951540484603, 4848.515148485141, 4583.335416364608, 4817.494163112875, 4843.9515604843855, 4849.151398505247, 4862.6839255448285, 4022.456968309299, 4023.6781057515327, 4026.4900662251657, 4068.613481719232, 4189.518205406387, 6278.121063051177, 6310.0, 6379.457746091588, 6385.936140638627, 6406.487481001509, 5802.100674395476, 5808.4191580842, 5818.621789583706, 5819.7090145492975, 5819.854503637443, 6608.207015158164, 6678.232003319632, 6820.386165245102, 7008.264132266089, 7011.684474198673, 4724.95275047252, 4738.526147385269, 4739.573438390527, 4744.169770290186, 4753.33453316536, 7511.699532018767, 7516.060492438445, 7518.962405187939, 7522.586257755821, 7531.246875312425, 3857.305684976675, 4434.445694288214, 4797.584712509818, 4800.447948485899, 4816.036792641486, 4725.3384526166365, 4744.976275118672, 4745.2882067690125, 4745.311929770164, 4748.216544270157, 4598.517155698671, 5627.71861406928, 5635.21107045014, 5650.152477128464, 5654.208410822406, 5957.106434034843, 7078.301207710112, 7081.150261968597, 7090.361867431956, 7100.360967512948, 1577.8895477316478, 1600.7678886561384, 1646.1769115442278, 1649.7277949138258, 1651.0176445015197, 892.3040028777564, 989.980200395988, 1053.5311786255043, 1067.9800790245297, 1068.4871261794383, 5812.854678632983, 6483.092367068614, 6488.188976377953, 6491.415772580491, 6501.317361676955, 5827.388124246978, 7310.305520975605, 7323.0480037595835, 7323.963380183065, 7353.70585176587, 6253.1245625612455, 6427.325130861286, 6441.774537891151, 6452.870942581122, 6470.45001174896, 3827.559830619459, 3869.941950870739, 3870.6903447724676, 3871.8064096795047, 3884.3590807517007, 7402.259774022555, 7590.127135379502, 7614.8096297593, 7623.199564045695, 7626.351760100453, 7455.776326710207, 7658.387329013777, 7688.154303026663, 7711.383089352838, 7716.2669546393, 7485.288897554724, 7684.615769211517, 7684.884726729216, 7686.116096648957, 7717.884231736529, 5936.5844390892225, 7377.151627562685, 7405.629718513945, 7408.62956852166, 7418.332350088518, 7296.270372962661, 7318.268173182639, 7325.706971721072, 7327.596982165819, 7328.670209840463, 7441.144268408986, 7696.384289256958, 7723.382129429745, 7739.032620922385, 7746.612669366396, 4641.257398816173, 4683.133620280123, 4693.389859318267, 4696.2251228548275, 4700.811967521261, 7418.1839997599145, 7421.666025028779, 7444.143923448873, 7450.813729656585, 7464.552126872188, 6914.55055421396, 7135.964320178366, 7157.427405807419, 7168.53404528704, 7173.497855150089, 7147.428205743632, 7154.8177805767655, 7156.785296441115, 7160.0, 7170.139583250043, 6731.427828634621, 6971.616561088986, 6971.651417429007, 6981.5461994970165, 6986.720531178899, 5750.424957504383, 6137.895178867847, 6440.774572889926, 7138.821529461805, 7142.642867856483, 6985.231624521197, 6990.161180658353, 6990.23107458169, 6999.09011828459, 6999.515172113826], "unit": "ms", "name": "prototype.html", "value": 5133.654345097171}, {"lowerIsBetter": false, "replicates": [744.5718711740749, 761.9466637335386, 789.6841263494604, 816.1878930464185, 844.9873251901219, 13438.798418023725, 13763.449462021532, 13780.655483612914, 13784.104033237845, 13784.310784460788, 13998.230097344642, 14116.0, 14116.858831411682, 14117.57647270581, 14122.43510259591, 767.1561282589136, 769.461377036077, 774.3224678406394, 960.3325688646394, 967.7483854197924, 955.8661787349777, 966.0436168193509, 968.3608818180003, 970.8786401699788, 972.6206779356057, 1011.8532812742149, 1020.3265844542603, 1022.982132777887, 1024.2727663359024, 1026.112412762962, 805.0500409516768, 805.4402190477621, 1005.0452070533023, 1014.2342531388828, 1030.6856408795315, 764.7094104240408, 768.5926458976751, 771.656612807301, 772.4168252968973, 773.9496932699357, 14666.853331466655, 14863.33115009827, 14882.330295136637, 14913.956023078388, 14922.2538873057, 12486.81269780954, 12629.810552841715, 12827.166234194747, 12858.099933004694, 13095.738085238338, 9263.775702417037, 10066.513750006265, 10223.131033862132, 10287.177025837915, 10433.634822781241, 3520.2431477232262, 3565.2156525564333, 3577.94633080504, 3583.6595523425235, 3778.9055273618105, 78982.0, 81555.0, 83312.16687833166, 84141.0, 84250.57874710648, 9593.232541396672, 9609.327347085777, 9645.035496450299, 9826.115649591571, 9914.80170396588, 22288.0, 22295.0, 22304.996275167658, 22314.21900233484, 22355.217567385065, 7219.0, 7228.49400541957, 7245.492815502969, 7324.08448943882, 7406.7037318506655, 3903.316919539069, 3958.8614398495915, 3995.34076877312, 4004.979975100106, 4012.0, 2940.911772646824, 3487.2502411981545, 3540.238848647553, 3546.5212196353677, 3552.946705799415, 628.0558095162387, 629.468099455959, 631.1479502671357, 650.632392698124, 654.1332734127301, 516.5583426170646, 517.6531723745024, 531.7766538054027, 555.5444535480867, 621.3227581935621, 8827.779305517413, 9200.355975081813, 9210.401323913924, 9217.308701847254, 9218.492982885871, 548.5748544877752, 595.4194660206351, 606.7724603273772, 613.5980932489226, 624.3382015064046, 3726.571444283888, 3743.812809359521, 3862.1117143057254, 3912.0, 4059.594040595917, 90016.09983900208, 91392.08607913836, 91667.0, 91906.54046729724, 92326.53836730773, 78136.2186378129, 78180.0, 78331.0, 79176.0, 79777.0, 66507.0, 66606.0, 66813.66593167002, 67195.32804671988, 68214.65892670605, 8067.193280672121, 8293.502389856629, 8400.28597569189, 8894.155055269739, 9064.365494415328, 50510.74744626253, 50889.74555127349, 51515.0, 52413.47586524086, 52824.47175528196, 72587.0, 73235.0, 73574.63212683902, 74220.0, 75645.0, 10881.401522916, 10951.83572246433, 10974.506147223234, 11501.424928753362, 11703.88296117062, 11846.348450835287, 11978.700532486757, 12020.278783273032, 12023.977961872988, 12686.555970540987, 10032.498375081363, 10053.547590358305, 10100.191984641064, 10102.69691909244, 10158.644447444303, 11400.828987565359, 11446.656600302003, 11476.368799715761, 11728.88575585318, 12231.75536489283, 11142.832857507306, 11261.380624065756, 11364.54541818318, 11366.772664546497, 11474.139439541901, 9871.555779989774, 9923.508566146002, 9961.452120133463, 10203.795924081625, 10374.0, 8495.853059836843, 9682.225421966366, 9822.901770982198, 10037.849432258668, 10070.546825392728], "unit": "ms", "name": "yui.html", "value": 6971.781844687591}], "name": "dromaeo_css", "value": 7701.831223983371}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 110.0, 104.0, 109.0, 110.0, 110.0, 108.0, 109.0, 100.0, 108.0], "unit": "ms", "name": "ai-astar", "value": 107.6}, {"lowerIsBetter": true, "replicates": [147.0, 120.0, 142.0, 153.0, 118.0, 140.0, 138.0, 118.0, 156.0, 138.0], "unit": "ms", "name": "audio-beat-detection", "value": 137.0}, {"lowerIsBetter": true, "replicates": [183.0, 182.0, 181.0, 183.0, 184.0, 183.0, 183.0, 184.0, 187.0, 182.0], "unit": "ms", "name": "audio-dft", "value": 183.2}, {"lowerIsBetter": true, "replicates": [60.0, 70.0, 74.0, 73.0, 54.0, 56.0, 56.0, 69.0, 72.0, 54.0], "unit": "ms", "name": "audio-fft", "value": 63.8}, {"lowerIsBetter": true, "replicates": [83.0, 86.0, 112.0, 74.0, 77.0, 74.0, 106.0, 70.0, 74.0, 105.0], "unit": "ms", "name": "audio-oscillator", "value": 86.1}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 84.0, 84.0, 86.0, 85.0, 85.0, 88.0, 84.0, 83.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 84.8}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 92.0, 92.0, 92.0, 92.0, 93.0, 91.0, 92.0, 92.0], "unit": "ms", "name": "imaging-darkroom", "value": 92.0}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 83.0, 84.0, 87.0, 87.0, 86.0, 84.0, 85.0, 86.0], "unit": "ms", "name": "imaging-desaturate", "value": 85.1}, {"lowerIsBetter": true, "replicates": [57.0, 55.0, 55.0, 54.0, 55.0, 54.0, 53.0, 61.0, 51.0, 51.0], "unit": "ms", "name": "json-parse-financial", "value": 54.6}, {"lowerIsBetter": true, "replicates": [63.0, 62.0, 63.0, 65.0, 95.0, 97.0, 97.0, 66.0, 68.0, 67.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 74.3}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 83.0, 76.0, 83.0, 82.0, 81.0, 84.0, 84.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 82.1}, {"lowerIsBetter": true, "replicates": [126.0, 127.0, 121.0, 127.0, 115.0, 134.0, 121.0, 122.0, 126.0, 135.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 125.4}, {"lowerIsBetter": true, "replicates": [134.0, 135.0, 132.0, 134.0, 134.0, 134.0, 135.0, 133.0, 131.0, 123.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 132.5}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 65.0, 64.0, 65.0, 64.0, 63.0, 65.0, 65.0, 65.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 64.2}], "name": "kraken", "value": 1372.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [173.28019407381737], "unit": "score", "name": "Richards", "value": 203.72784199999998}, {"lowerIsBetter": false, "replicates": [161.53970043485262], "unit": "score", "name": "DeltaBlue", "value": 409.2987657028912}, {"lowerIsBetter": false, "replicates": [278.1641168289291], "unit": "score", "name": "Encrypt", "value": 956.9206949999998}, {"lowerIsBetter": false, "replicates": [4643.518518518518], "unit": "score", "name": "Decrypt", "value": 57.323126620139575}, {"lowerIsBetter": false, "replicates": [1730.1038062283737], "unit": "score", "name": "RayTrace", "value": 427.71364199999994}, {"lowerIsBetter": false, "replicates": [787.4015748031496], "unit": "score", "name": "Earley", "value": 846.4080099999996}, {"lowerIsBetter": false, "replicates": [12444.444444444445], "unit": "score", "name": "Boyer", "value": 53.555062500000005}, {"lowerIsBetter": false, "replicates": [28828.571428571428], "unit": "score", "name": "RegExp", "value": 31.6000743310208}, {"lowerIsBetter": false, "replicates": [656.1679790026246], "unit": "score", "name": "Splay", "value": 124.19228399999994}, {"lowerIsBetter": false, "replicates": [4468.75], "unit": "score", "name": "NavierStokes", "value": 332.08391608391634}], "name": "v8_7", "value": 20326.27720256463}]} 00:13:53 INFO - RETURN: dromaeo_css: 7701.83 00:13:53 INFO - RETURN: kraken: 1372.70 00:13:53 INFO - RETURN: v8_7: 20326.28 00:13:53 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,59]]", "result": "20326.28"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1372.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7701.83"}}} 00:13:53 INFO - Return code: 0 00:13:53 INFO - # TBPL SUCCESS # 00:13:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:13:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:13:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:13:53 INFO - 2015-11-24 00:13:53.494 screenresolution[1679:12181] starting screenresolution argv=screenresolution get 00:13:53 INFO - 2015-11-24 00:13:53.497 screenresolution[1679:12181] Display 0: 1600x1200x32@60 00:13:53 INFO - 2015-11-24 00:13:53.503 screenresolution[1680:12185] starting screenresolution argv=screenresolution list 00:13:53 INFO - Available Modes on Display 0 00:13:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:13:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:13:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:13:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:13:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:13:53 INFO - Intel Iris: 00:13:53 INFO - Chipset Model: Intel Iris 00:13:53 INFO - Type: GPU 00:13:53 INFO - Bus: Built-In 00:13:53 INFO - VRAM (Dynamic, Max): 1536 MB 00:13:53 INFO - Vendor: Intel (0x8086) 00:13:53 INFO - Device ID: 0x0a2e 00:13:53 INFO - Revision ID: 0x0009 00:13:53 INFO - Displays: 00:13:53 INFO - Display: 00:13:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:13:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:13:53 INFO - Display Serial Number: 1600x1200 60 00:13:53 INFO - Main Display: Yes 00:13:53 INFO - Mirror: Off 00:13:53 INFO - Online: Yes 00:13:53 INFO - Rotation: Supported 00:13:53 INFO - Return code: 0 00:13:53 INFO - Running post-action listener: _resource_record_post_action 00:13:53 INFO - Running post-run listener: _resource_record_post_run 00:13:54 INFO - Total resource usage - Wall time: 1237s; CPU: 53.0%; Read bytes: 34520576; Write bytes: 691790336; Read time: 433; Write time: 2160 00:13:54 INFO - install - Wall time: 30s; CPU: 54.0%; Read bytes: 342032896; Write bytes: 336864768; Read time: 26082; Write time: 581 00:13:54 INFO - run-tests - Wall time: 1207s; CPU: 53.0%; Read bytes: 32439808; Write bytes: 343301120; Read time: 410; Write time: 1542 00:13:54 INFO - Running post-run listener: _upload_blobber_files 00:13:54 INFO - Blob upload gear active. 00:13:54 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 00:13:54 INFO - Copying logs to upload dir... 00:13:54 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1283.995602 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2015-11-24 00:13:54.852976) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 00:13:54.856506) ========= 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.C0BS0AOWsI/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.GFVPXWxp90/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009617 build_url: 'https://queue.taskcluster.net/v1/task/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 00:13:54.884525) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 00:13:54.884852) ========= 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.C0BS0AOWsI/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.GFVPXWxp90/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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.005009 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 00:13:54.936842) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 00:13:54.937332) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 00:13:54.937724) ========= ========= Total master_lag: 0.26 =========