builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0022 starttime: 1447869846.7 results: success (0) buildid: 20151118081929 builduid: ff41da31ee5d4350a42d3faf12670d9b revision: 43075970a44ea086084135bb0a100245ecb3bde7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 10:04:06.702486) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 10:04:06.702878) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 10:04:06.703155) ========= 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.YOB6E0GDyM/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.y7jawezWp7/Listeners TMPDIR=/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/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.005526 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 10:04:06.739924) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 10:04:06.740212) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 10:04:06.899674) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 10:04:06.899974) ========= 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.YOB6E0GDyM/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.y7jawezWp7/Listeners TMPDIR=/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/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.005721 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 10:04:06.947700) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 10:04:06.947966) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 10:04:06.948342) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 10:04:06.948635) ========= 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.YOB6E0GDyM/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.y7jawezWp7/Listeners TMPDIR=/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/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-18 10:04:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 17.6M=0.001s 2015-11-18 10:04:07 (17.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.577121 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 10:04:07.539036) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 10:04:07.539359) ========= 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.YOB6E0GDyM/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.y7jawezWp7/Listeners TMPDIR=/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/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.025158 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 10:04:07.630952) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-18 10:04:07.631283) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 43075970a44ea086084135bb0a100245ecb3bde7 --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 43075970a44ea086084135bb0a100245ecb3bde7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.YOB6E0GDyM/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.y7jawezWp7/Listeners TMPDIR=/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/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-18 10:04:07,727 truncating revision to first 12 chars 2015-11-18 10:04:07,727 Setting DEBUG logging. 2015-11-18 10:04:07,727 attempt 1/10 2015-11-18 10:04:07,727 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/43075970a44e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-18 10:04:08,559 unpacking tar archive at: fx-team-43075970a44e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.076139 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-18 10:04:08.737271) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 10:04:08.737572) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 10:04:08.752395) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 10:04:08.752684) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 10:04:08.753098) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 33 secs) (at 2015-11-18 10:04:08.753698) ========= /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.YOB6E0GDyM/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.y7jawezWp7/Listeners TMPDIR=/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/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 10:04:08 INFO - MultiFileLogger online at 20151118 10:04:08 in /builds/slave/test 10:04:08 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 10:04:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:04:08 INFO - {'append_to_log': False, 10:04:08 INFO - 'base_work_dir': '/builds/slave/test', 10:04:08 INFO - 'blob_upload_branch': 'Fx-Team', 10:04:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:04:08 INFO - 'branch': 'Fx-Team', 10:04:08 INFO - 'buildbot_json_path': 'buildprops.json', 10:04:08 INFO - 'config_files': ('talos/mac_config.py',), 10:04:08 INFO - 'default_actions': ('clobber', 10:04:08 INFO - 'read-buildbot-config', 10:04:08 INFO - 'download-and-extract', 10:04:08 INFO - 'populate-webroot', 10:04:08 INFO - 'create-virtualenv', 10:04:08 INFO - 'install', 10:04:08 INFO - 'run-tests'), 10:04:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:04:08 INFO - 'download_minidump_stackwalk': True, 10:04:08 INFO - 'download_symbols': 'ondemand', 10:04:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:04:08 INFO - 'tooltool.py': '/tools/tooltool.py', 10:04:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:04:08 INFO - '/tools/misc-python/virtualenv.py')}, 10:04:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:04:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:04:08 INFO - 'installer_path': 'installer.exe', 10:04:08 INFO - 'log_level': 'info', 10:04:08 INFO - 'log_name': 'talos', 10:04:08 INFO - 'log_to_console': True, 10:04:08 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:04:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:04:08 INFO - 'opt_config_files': (), 10:04:08 INFO - 'pip_index': False, 10:04:08 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:04:08 INFO - 'cmd': ('bash', 10:04:08 INFO - '-c', 10:04:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:04:08 INFO - 'enabled': True, 10:04:08 INFO - 'halt_on_failure': False, 10:04:08 INFO - 'name': 'check_screen_resolution'},), 10:04:08 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:04:08 INFO - 'cmd': ('bash', 10:04:08 INFO - '-c', 10:04:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:04:08 INFO - 'enabled': True, 10:04:08 INFO - 'halt_on_failure': False, 10:04:08 INFO - 'name': 'check_screen_resolution'},), 10:04:08 INFO - 'run_cmd_checks_enabled': True, 10:04:08 INFO - 'sps_profile': False, 10:04:08 INFO - 'sps_profile_interval': 0, 10:04:08 INFO - 'suite': 'dromaeojs', 10:04:08 INFO - 'system_bits': '64', 10:04:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:04:08 INFO - 'title': 't-yosemite-r7-0022', 10:04:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:04:08 INFO - 'use_talos_json': True, 10:04:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:04:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:04:08 INFO - 'work_dir': 'build'} 10:04:08 INFO - ##### 10:04:08 INFO - ##### Running clobber step. 10:04:08 INFO - ##### 10:04:08 INFO - Running pre-action listener: _resource_record_pre_action 10:04:08 INFO - Running main action method: clobber 10:04:08 INFO - rmtree: /builds/slave/test/build 10:04:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:04:10 INFO - Running post-action listener: _resource_record_post_action 10:04:10 INFO - ##### 10:04:10 INFO - ##### Running read-buildbot-config step. 10:04:10 INFO - ##### 10:04:10 INFO - Running pre-action listener: _resource_record_pre_action 10:04:10 INFO - Running main action method: read_buildbot_config 10:04:10 INFO - Using buildbot properties: 10:04:10 INFO - { 10:04:10 INFO - "properties": { 10:04:10 INFO - "buildnumber": 0, 10:04:10 INFO - "product": "firefox", 10:04:10 INFO - "script_repo_revision": "production", 10:04:10 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 10:04:10 INFO - "repository": "", 10:04:10 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 10:04:10 INFO - "buildid": "20151118081929", 10:04:10 INFO - "slavename": "t-yosemite-r7-0022", 10:04:10 INFO - "pgo_build": "False", 10:04:10 INFO - "basedir": "/builds/slave/test", 10:04:10 INFO - "project": "", 10:04:10 INFO - "platform": "yosemite_r7", 10:04:10 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 10:04:10 INFO - "slavebuilddir": "test", 10:04:10 INFO - "scheduler": "tests-fx-team-macosx64-talos", 10:04:10 INFO - "branch": "fx-team", 10:04:10 INFO - "repo_path": "integration/fx-team", 10:04:10 INFO - "stage_platform": "macosx64", 10:04:10 INFO - "builduid": "ff41da31ee5d4350a42d3faf12670d9b", 10:04:10 INFO - "revision": "43075970a44ea086084135bb0a100245ecb3bde7" 10:04:10 INFO - }, 10:04:10 INFO - "sourcestamp": { 10:04:10 INFO - "repository": "", 10:04:10 INFO - "hasPatch": false, 10:04:10 INFO - "project": "", 10:04:10 INFO - "branch": "fx-team-macosx64-talos", 10:04:10 INFO - "changes": [ 10:04:10 INFO - { 10:04:10 INFO - "category": null, 10:04:10 INFO - "files": [ 10:04:10 INFO - { 10:04:10 INFO - "url": null, 10:04:10 INFO - "name": "https://queue.taskcluster.net/v1/task/H0ZS5RUcQU6LaCIHt42nUA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 10:04:10 INFO - } 10:04:10 INFO - ], 10:04:10 INFO - "repository": "", 10:04:10 INFO - "rev": "43075970a44ea086084135bb0a100245ecb3bde7", 10:04:10 INFO - "who": "mdeboer@mozilla.com", 10:04:10 INFO - "when": 1447869816, 10:04:10 INFO - "number": 6678086, 10:04:10 INFO - "comments": "Bug 1048850 - Part 6: make sure our mochi tests don't depend on mozLoopAPI anymore and move relevant ones to xpcshell. r=Standard8", 10:04:10 INFO - "project": "", 10:04:10 INFO - "at": "Wed 18 Nov 2015 10:03:36", 10:04:10 INFO - "branch": "fx-team-macosx64-talos", 10:04:10 INFO - "revlink": "", 10:04:10 INFO - "properties": [ 10:04:10 INFO - [ 10:04:10 INFO - "buildid", 10:04:10 INFO - "20151118081929", 10:04:10 INFO - "Change" 10:04:10 INFO - ], 10:04:10 INFO - [ 10:04:10 INFO - "builduid", 10:04:10 INFO - "ff41da31ee5d4350a42d3faf12670d9b", 10:04:10 INFO - "Change" 10:04:10 INFO - ], 10:04:10 INFO - [ 10:04:10 INFO - "pgo_build", 10:04:10 INFO - "False", 10:04:10 INFO - "Change" 10:04:10 INFO - ] 10:04:10 INFO - ], 10:04:10 INFO - "revision": "43075970a44ea086084135bb0a100245ecb3bde7" 10:04:10 INFO - } 10:04:10 INFO - ], 10:04:10 INFO - "revision": "43075970a44ea086084135bb0a100245ecb3bde7" 10:04:10 INFO - } 10:04:10 INFO - } 10:04:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/H0ZS5RUcQU6LaCIHt42nUA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 10:04:10 INFO - Running post-action listener: _resource_record_post_action 10:04:10 INFO - ##### 10:04:10 INFO - ##### Running download-and-extract step. 10:04:10 INFO - ##### 10:04:10 INFO - Running pre-action listener: _resource_record_pre_action 10:04:10 INFO - Running main action method: download_and_extract 10:04:10 INFO - mkdir: /builds/slave/test/build/tests 10:04: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')]} 10:04:10 INFO - https://queue.taskcluster.net/v1/task/H0ZS5RUcQU6LaCIHt42nUA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:04:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H0ZS5RUcQU6LaCIHt42nUA/artifacts/public/build/test_packages.json 10:04:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H0ZS5RUcQU6LaCIHt42nUA/artifacts/public/build/test_packages.json 10:04:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H0ZS5RUcQU6LaCIHt42nUA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 10:04:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H0ZS5RUcQU6LaCIHt42nUA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 10:04:15 INFO - Downloaded 1149 bytes. 10:04:15 INFO - Reading from file /builds/slave/test/build/test_packages.json 10:04:15 INFO - Using the following test package requirements: 10:04:15 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 10:04:15 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 10:04:15 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 10:04:15 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 10:04:15 INFO - u'jsshell-mac.zip'], 10:04:15 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 10:04:15 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 10:04:15 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 10:04:15 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 10:04:15 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 10:04:15 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 10:04:15 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 10:04:15 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 10:04:15 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 10:04:15 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 10:04:15 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 10:04:15 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 10:04:15 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:04: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')]} 10:04:15 INFO - https://queue.taskcluster.net/v1/task/H0ZS5RUcQU6LaCIHt42nUA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:04:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H0ZS5RUcQU6LaCIHt42nUA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 10:04:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H0ZS5RUcQU6LaCIHt42nUA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 10:04:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H0ZS5RUcQU6LaCIHt42nUA/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 10:04:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H0ZS5RUcQU6LaCIHt42nUA/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 10:04:22 INFO - Downloaded 17476915 bytes. 10:04:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 10:04:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 10:04:22 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 10:04:25 INFO - Return code: 0 10:04:25 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 10:04:25 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')]} 10:04:25 INFO - https://queue.taskcluster.net/v1/task/H0ZS5RUcQU6LaCIHt42nUA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:04:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H0ZS5RUcQU6LaCIHt42nUA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 10:04:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H0ZS5RUcQU6LaCIHt42nUA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 10:04:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H0ZS5RUcQU6LaCIHt42nUA/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 10:04:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H0ZS5RUcQU6LaCIHt42nUA/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 10:04:26 INFO - Downloaded 17476915 bytes. 10:04:26 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 10:04:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 10:04:26 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 10:04:29 INFO - Return code: 0 10:04:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:29 INFO - https://queue.taskcluster.net/v1/task/H0ZS5RUcQU6LaCIHt42nUA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 10:04:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H0ZS5RUcQU6LaCIHt42nUA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 10:04:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H0ZS5RUcQU6LaCIHt42nUA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 10:04:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H0ZS5RUcQU6LaCIHt42nUA/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 10:04:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H0ZS5RUcQU6LaCIHt42nUA/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 10:04:30 INFO - Downloaded 11130997 bytes. 10:04:30 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 10:04:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 10:04:30 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 10:04:31 INFO - Return code: 0 10:04:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:31 INFO - https://queue.taskcluster.net/v1/task/H0ZS5RUcQU6LaCIHt42nUA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 10:04:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H0ZS5RUcQU6LaCIHt42nUA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 10:04:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H0ZS5RUcQU6LaCIHt42nUA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 10:04:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H0ZS5RUcQU6LaCIHt42nUA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 10:04:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H0ZS5RUcQU6LaCIHt42nUA/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 10:04:35 INFO - Downloaded 108852653 bytes. 10:04:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/H0ZS5RUcQU6LaCIHt42nUA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 10:04:35 INFO - mkdir: /builds/slave/test/properties 10:04:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:04:35 INFO - Writing to file /builds/slave/test/properties/build_url 10:04:35 INFO - Contents: 10:04:35 INFO - build_url:https://queue.taskcluster.net/v1/task/H0ZS5RUcQU6LaCIHt42nUA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 10:04:35 INFO - Running post-action listener: _resource_record_post_action 10:04:35 INFO - Running post-action listener: set_extra_try_arguments 10:04:35 INFO - ##### 10:04:35 INFO - ##### Running populate-webroot step. 10:04:35 INFO - ##### 10:04:35 INFO - Running pre-action listener: _resource_record_pre_action 10:04:35 INFO - Running main action method: populate_webroot 10:04:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:04:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:04:35 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 10:04:35 INFO - '../fennec_ids.txt'], 10:04:35 INFO - 'tests': ['tcheck2']}, 10:04:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:04:35 INFO - '--tppagecycles', 10:04:35 INFO - '7'], 10:04:35 INFO - 'tests': ['tsvgm']}}, 10:04:35 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:04:35 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:04:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:04:35 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:04:35 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:04:35 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:04:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:04:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:35 INFO - 'talos_options': ['--e10s'], 10:04:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:04:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:35 INFO - 'tests': ['damp', 'tps']}, 10:04:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:35 INFO - 'talos_options': ['--e10s'], 10:04:35 INFO - 'tests': ['damp', 'tps']}, 10:04:35 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:04:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:04:35 INFO - 'other': {'tests': ['a11yr', 10:04:35 INFO - 'ts_paint', 10:04:35 INFO - 'tpaint', 10:04:35 INFO - 'sessionrestore', 10:04:35 INFO - 'sessionrestore_no_auto_restore']}, 10:04:35 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:04:35 INFO - 'tests': ['a11yr', 10:04:35 INFO - 'ts_paint', 10:04:35 INFO - 'tpaint', 10:04:35 INFO - 'sessionrestore', 10:04:35 INFO - 'sessionrestore_no_auto_restore']}, 10:04:35 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:04:35 INFO - 'tests': ['a11yr', 10:04:35 INFO - 'ts_paint', 10:04:35 INFO - 'tpaint', 10:04:35 INFO - 'sessionrestore', 10:04:35 INFO - 'sessionrestore_no_auto_restore']}, 10:04:35 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:04:35 INFO - 'tests': ['a11yr', 10:04:35 INFO - 'ts_paint', 10:04:35 INFO - 'tpaint', 10:04:35 INFO - 'sessionrestore', 10:04:35 INFO - 'sessionrestore_no_auto_restore']}, 10:04:35 INFO - 'other_l64': {'tests': ['a11yr', 10:04:35 INFO - 'ts_paint', 10:04:35 INFO - 'tpaint', 10:04:35 INFO - 'sessionrestore', 10:04:35 INFO - 'sessionrestore_no_auto_restore']}, 10:04:35 INFO - 'other_nol64': {'tests': ['a11yr', 10:04:35 INFO - 'ts_paint', 10:04:35 INFO - 'tpaint', 10:04:35 INFO - 'sessionrestore', 10:04:35 INFO - 'sessionrestore_no_auto_restore']}, 10:04:35 INFO - 'svgr': {'tests': ['tsvgx', 10:04:35 INFO - 'tsvgr_opacity', 10:04:35 INFO - 'tart', 10:04:35 INFO - 'tscrollx', 10:04:35 INFO - 'cart']}, 10:04:35 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:04:35 INFO - 'tests': ['tsvgx', 10:04:35 INFO - 'tsvgr_opacity', 10:04:35 INFO - 'tart', 10:04:35 INFO - 'tscrollx', 10:04:35 INFO - 'cart']}, 10:04:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:35 INFO - 'tests': ['tp5o']}, 10:04:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:35 INFO - 'talos_options': ['--e10s'], 10:04:35 INFO - 'tests': ['tp5o']}, 10:04:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:35 INFO - 'talos_options': ['--xperf_path', 10:04:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:04:35 INFO - 'tests': ['tp5n']}, 10:04:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:35 INFO - 'talos_options': ['--e10s', 10:04:35 INFO - '--xperf_path', 10:04:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:04:35 INFO - 'tests': ['tp5n']}}, 10:04:35 INFO - 'talos.zip': {'path': '', 10:04:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:04:35 INFO - Running post-action listener: _resource_record_post_action 10:04:35 INFO - ##### 10:04:35 INFO - ##### Running create-virtualenv step. 10:04:35 INFO - ##### 10:04:35 INFO - Running pre-action listener: _resource_record_pre_action 10:04:35 INFO - Running main action method: create_virtualenv 10:04:35 INFO - Creating virtualenv /builds/slave/test/build/venv 10:04:35 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 10:04:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:04:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:04:36 INFO - Using real prefix '/tools/python27' 10:04:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:04:36 INFO - Installing distribute.............................................................................................................................................................................................done. 10:04:39 INFO - Installing pip.................done. 10:04:39 INFO - Return code: 0 10:04:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:04:39 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')]} 10:04:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:39 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')]} 10:04:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:39 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 0x10b98f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b96c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f903b47b120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8b39f0>, '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 0x10b612db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8a68c8>, '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.YOB6E0GDyM/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.y7jawezWp7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/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 10:04:39 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 10:04:39 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 10:04:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YOB6E0GDyM/Render', 10:04:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:04:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:04:39 INFO - 'HOME': '/Users/cltbld', 10:04:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:04:39 INFO - 'LOGNAME': 'cltbld', 10:04:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:39 INFO - 'MOZ_NO_REMOTE': '1', 10:04:39 INFO - 'NO_EM_RESTART': '1', 10:04:39 INFO - 'PAGER': '/bin/cat', 10:04:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:04:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:39 INFO - 'PWD': '/builds/slave/test', 10:04:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:04:39 INFO - 'SHELL': '/bin/bash', 10:04:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.y7jawezWp7/Listeners', 10:04:39 INFO - 'TMPDIR': '/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/', 10:04:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:04:39 INFO - 'USER': 'cltbld', 10:04:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:04:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:04:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:39 INFO - 'XPC_FLAGS': '0x0', 10:04:39 INFO - 'XPC_SERVICE_NAME': '0', 10:04:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:04:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:39 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 10:04:39 INFO - Cleaning up... 10:04:39 INFO - Return code: 0 10:04:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:04:39 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')]} 10:04:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:39 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')]} 10:04:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:39 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 0x10b98f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b96c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f903b47b120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8b39f0>, '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 0x10b612db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8a68c8>, '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.YOB6E0GDyM/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.y7jawezWp7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/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 10:04:39 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 10:04:39 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 10:04:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YOB6E0GDyM/Render', 10:04:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:04:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:04:39 INFO - 'HOME': '/Users/cltbld', 10:04:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:04:39 INFO - 'LOGNAME': 'cltbld', 10:04:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:39 INFO - 'MOZ_NO_REMOTE': '1', 10:04:39 INFO - 'NO_EM_RESTART': '1', 10:04:39 INFO - 'PAGER': '/bin/cat', 10:04:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:04:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:39 INFO - 'PWD': '/builds/slave/test', 10:04:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:04:39 INFO - 'SHELL': '/bin/bash', 10:04:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.y7jawezWp7/Listeners', 10:04:39 INFO - 'TMPDIR': '/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/', 10:04:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:04:39 INFO - 'USER': 'cltbld', 10:04:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:04:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:04:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:39 INFO - 'XPC_FLAGS': '0x0', 10:04:39 INFO - 'XPC_SERVICE_NAME': '0', 10:04:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:04:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:40 INFO - Downloading/unpacking psutil>=0.7.1 10:04:40 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 10:04:40 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 10:04:40 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 10:04:40 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 10:04:40 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 10:04:40 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 10:04:42 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 10:04:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:04:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:04:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:04:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:04:42 INFO - Installing collected packages: psutil 10:04:42 INFO - Running setup.py install for psutil 10:04:43 INFO - building 'psutil._psutil_osx' extension 10:04:43 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 10:04:43 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 10:04:43 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 10:04:43 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 10:04:43 INFO - building 'psutil._psutil_posix' extension 10:04:43 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 10:04:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:04:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:04:43 INFO - ^ 10:04:44 INFO - 1 warning generated. 10:04:44 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 10:04:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:04:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:04:44 INFO - Successfully installed psutil 10:04:44 INFO - Cleaning up... 10:04:44 INFO - Return code: 0 10:04:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:04:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b98f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b96c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f903b47b120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8b39f0>, '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 0x10b612db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8a68c8>, '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.YOB6E0GDyM/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.y7jawezWp7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/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 10:04:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 10:04:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:04:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YOB6E0GDyM/Render', 10:04:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:04:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:04:44 INFO - 'HOME': '/Users/cltbld', 10:04:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:04:44 INFO - 'LOGNAME': 'cltbld', 10:04:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:44 INFO - 'MOZ_NO_REMOTE': '1', 10:04:44 INFO - 'NO_EM_RESTART': '1', 10:04:44 INFO - 'PAGER': '/bin/cat', 10:04:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:04:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:44 INFO - 'PWD': '/builds/slave/test', 10:04:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:04:44 INFO - 'SHELL': '/bin/bash', 10:04:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.y7jawezWp7/Listeners', 10:04:44 INFO - 'TMPDIR': '/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/', 10:04:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:04:44 INFO - 'USER': 'cltbld', 10:04:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:04:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:04:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:44 INFO - 'XPC_FLAGS': '0x0', 10:04:44 INFO - 'XPC_SERVICE_NAME': '0', 10:04:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:04:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:04:44 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 10:04:44 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 10:04:44 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 10:04:44 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 10:04:44 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 10:04:44 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 10:04:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:04:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:04:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:04:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:04:46 INFO - Installing collected packages: mozsystemmonitor 10:04:46 INFO - Running setup.py install for mozsystemmonitor 10:04:46 INFO - Successfully installed mozsystemmonitor 10:04:46 INFO - Cleaning up... 10:04:46 INFO - Return code: 0 10:04:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:04: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')]} 10:04:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04: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')]} 10:04:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:46 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 0x10b98f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b96c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f903b47b120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8b39f0>, '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 0x10b612db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8a68c8>, '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.YOB6E0GDyM/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.y7jawezWp7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/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 10:04:46 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 10:04:46 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 10:04:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YOB6E0GDyM/Render', 10:04:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:04:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:04:46 INFO - 'HOME': '/Users/cltbld', 10:04:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:04:46 INFO - 'LOGNAME': 'cltbld', 10:04:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:46 INFO - 'MOZ_NO_REMOTE': '1', 10:04:46 INFO - 'NO_EM_RESTART': '1', 10:04:46 INFO - 'PAGER': '/bin/cat', 10:04:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:04:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:46 INFO - 'PWD': '/builds/slave/test', 10:04:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:04:46 INFO - 'SHELL': '/bin/bash', 10:04:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.y7jawezWp7/Listeners', 10:04:46 INFO - 'TMPDIR': '/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/', 10:04:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:04:46 INFO - 'USER': 'cltbld', 10:04:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:04:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:04:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:46 INFO - 'XPC_FLAGS': '0x0', 10:04:46 INFO - 'XPC_SERVICE_NAME': '0', 10:04:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:04:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:47 INFO - Downloading/unpacking blobuploader==1.2.4 10:04:47 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 10:04:47 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 10:04:47 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 10:04:47 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 10:04:47 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 10:04:47 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 10:04:49 INFO - Downloading blobuploader-1.2.4.tar.gz 10:04:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:04:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:04:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:04:49 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 10:04:49 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 10:04:49 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 10:04:49 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 10:04:49 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 10:04:49 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 10:04:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:04:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:04:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:04:50 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 10:04:50 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 10:04:50 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 10:04:50 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 10:04:50 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 10:04:50 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 10:04:50 INFO - Downloading docopt-0.6.1.tar.gz 10:04:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:04:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:04:50 INFO - Installing collected packages: blobuploader, requests, docopt 10:04:50 INFO - Running setup.py install for blobuploader 10:04:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:04:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:04:50 INFO - Running setup.py install for requests 10:04:51 INFO - Running setup.py install for docopt 10:04:51 INFO - Successfully installed blobuploader requests docopt 10:04:51 INFO - Cleaning up... 10:04:51 INFO - Return code: 0 10:04:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:04:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:51 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 0x10b98f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b96c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f903b47b120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8b39f0>, '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 0x10b612db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8a68c8>, '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.YOB6E0GDyM/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.y7jawezWp7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/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 10:04:51 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 10:04:51 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 10:04:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YOB6E0GDyM/Render', 10:04:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:04:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:04:51 INFO - 'HOME': '/Users/cltbld', 10:04:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:04:51 INFO - 'LOGNAME': 'cltbld', 10:04:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:51 INFO - 'MOZ_NO_REMOTE': '1', 10:04:51 INFO - 'NO_EM_RESTART': '1', 10:04:51 INFO - 'PAGER': '/bin/cat', 10:04:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:04:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:51 INFO - 'PWD': '/builds/slave/test', 10:04:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:04:51 INFO - 'SHELL': '/bin/bash', 10:04:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.y7jawezWp7/Listeners', 10:04:51 INFO - 'TMPDIR': '/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/', 10:04:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:04:51 INFO - 'USER': 'cltbld', 10:04:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:04:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:04:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:51 INFO - 'XPC_FLAGS': '0x0', 10:04:51 INFO - 'XPC_SERVICE_NAME': '0', 10:04:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:04:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:04:51 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-ZqdcN7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:04:51 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-HS9Ezr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:04:51 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-4F5W24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:04:51 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-X2dXyr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:04:52 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-KIGlyh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:04:52 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-1aRfhN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:04:52 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-dw_gMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:04:52 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-Xzf9Kc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:04:52 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-pPXPEb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:04:52 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-RzNWtm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:04:52 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-xbn9x0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:04:52 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-Xe6MW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:04:52 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-4mHD7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:04:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:04:53 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-GgEYTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:04:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:04:53 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-_1cSR2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:04:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:04:53 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-ZZ0vG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:04:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:04:53 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-xgMLV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:04:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:04:53 INFO - Running setup.py install for manifestparser 10:04:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:04:53 INFO - Running setup.py install for mozcrash 10:04:53 INFO - Running setup.py install for mozdebug 10:04:53 INFO - Running setup.py install for mozdevice 10:04:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:04:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:04:54 INFO - Running setup.py install for mozfile 10:04:54 INFO - Running setup.py install for mozhttpd 10:04:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:04:54 INFO - Running setup.py install for mozinfo 10:04:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:04:54 INFO - Running setup.py install for mozInstall 10:04:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:04:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:04:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:04:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:04:54 INFO - Running setup.py install for mozleak 10:04:54 INFO - Running setup.py install for mozlog 10:04:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:04:54 INFO - Running setup.py install for moznetwork 10:04:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:04:55 INFO - Running setup.py install for mozprocess 10:04:55 INFO - Running setup.py install for mozprofile 10:04:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:04:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:04:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:04:55 INFO - Running setup.py install for mozrunner 10:04:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:04:55 INFO - Running setup.py install for mozscreenshot 10:04:55 INFO - Running setup.py install for moztest 10:04:55 INFO - Running setup.py install for mozversion 10:04:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:04:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:04:55 INFO - Cleaning up... 10:04:55 INFO - Return code: 0 10:04:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:04:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x10b98f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b96c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f903b47b120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8b39f0>, '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 0x10b612db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8a68c8>, '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.YOB6E0GDyM/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.y7jawezWp7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/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 10:04:55 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 10:04:55 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 10:04:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YOB6E0GDyM/Render', 10:04:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:04:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:04:55 INFO - 'HOME': '/Users/cltbld', 10:04:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:04:55 INFO - 'LOGNAME': 'cltbld', 10:04:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:55 INFO - 'MOZ_NO_REMOTE': '1', 10:04:55 INFO - 'NO_EM_RESTART': '1', 10:04:55 INFO - 'PAGER': '/bin/cat', 10:04:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:04:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:55 INFO - 'PWD': '/builds/slave/test', 10:04:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:04:55 INFO - 'SHELL': '/bin/bash', 10:04:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.y7jawezWp7/Listeners', 10:04:55 INFO - 'TMPDIR': '/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/', 10:04:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:04:55 INFO - 'USER': 'cltbld', 10:04:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:04:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:04:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:55 INFO - 'XPC_FLAGS': '0x0', 10:04:55 INFO - 'XPC_SERVICE_NAME': '0', 10:04:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:04:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:04:56 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-fsoeWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:04:56 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)) 10:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:04:56 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-FaME62-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:04:56 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)) 10:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:04:56 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-WB4Vut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:04:56 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)) 10:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:04:56 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-ILO4zv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:04:56 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)) 10:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:04:56 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-UScCPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:04:56 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)) 10:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:04:56 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-fAvkH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:04:56 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)) 10:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:04:56 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-3UxVYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:04:56 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)) 10:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:04:56 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-mPpJpJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:04:57 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)) 10:04:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:04:57 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-U84bHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:04:57 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)) 10:04:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:04:57 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-pkbLE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:04:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:04:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:04:57 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-hwTRRz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:04:57 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)) 10:04:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:04:57 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-QCkk8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:04:57 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)) 10:04:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:04:57 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-bK9KJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:04:57 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)) 10:04:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:04:57 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-Sku21o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:04:57 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)) 10:04:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:04:57 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-0Ekye0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:04:57 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)) 10:04:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:04:57 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-jNy5n_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:04:57 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)) 10:04:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:04:57 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-8ezPKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:04:58 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)) 10:04:58 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)) 10:04:58 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)) 10:04:58 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)) 10:04:58 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)) 10:04:58 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)) 10:04:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:04:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:00 INFO - Downloading blessings-1.5.1.tar.gz 10:05:00 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 10:05:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:05:00 INFO - Installing collected packages: blessings 10:05:00 INFO - Running setup.py install for blessings 10:05:00 INFO - Successfully installed blessings 10:05:00 INFO - Cleaning up... 10:05:00 INFO - Return code: 0 10:05:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:05:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:05:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:05:00 INFO - Reading from file tmpfile_stdout 10:05:00 INFO - Current package versions: 10:05:00 INFO - blessings == 1.5.1 10:05:00 INFO - blobuploader == 1.2.4 10:05:00 INFO - docopt == 0.6.1 10:05:00 INFO - manifestparser == 1.1 10:05:00 INFO - mozInstall == 1.12 10:05:00 INFO - mozcrash == 0.16 10:05:00 INFO - mozdebug == 0.1 10:05:00 INFO - mozdevice == 0.47 10:05:00 INFO - mozfile == 1.2 10:05:00 INFO - mozhttpd == 0.7 10:05:00 INFO - mozinfo == 0.9 10:05:00 INFO - mozleak == 0.1 10:05:00 INFO - mozlog == 3.0 10:05:00 INFO - moznetwork == 0.27 10:05:00 INFO - mozprocess == 0.22 10:05:00 INFO - mozprofile == 0.27 10:05:00 INFO - mozrunner == 6.11 10:05:00 INFO - mozscreenshot == 0.1 10:05:00 INFO - mozsystemmonitor == 0.0 10:05:00 INFO - moztest == 0.7 10:05:00 INFO - mozversion == 1.4 10:05:00 INFO - psutil == 3.1.1 10:05:00 INFO - requests == 1.2.3 10:05:00 INFO - wsgiref == 0.1.2 10:05:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:05:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:00 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 0x10b98f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b96c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f903b47b120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8b39f0>, '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 0x10b612db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8a68c8>, '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.YOB6E0GDyM/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.y7jawezWp7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/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 10:05:00 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 10:05:00 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 10:05:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YOB6E0GDyM/Render', 10:05:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:05:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:05:00 INFO - 'HOME': '/Users/cltbld', 10:05:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:05:00 INFO - 'LOGNAME': 'cltbld', 10:05:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:00 INFO - 'MOZ_NO_REMOTE': '1', 10:05:00 INFO - 'NO_EM_RESTART': '1', 10:05:00 INFO - 'PAGER': '/bin/cat', 10:05:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:05:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:00 INFO - 'PWD': '/builds/slave/test', 10:05:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:05:00 INFO - 'SHELL': '/bin/bash', 10:05:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.y7jawezWp7/Listeners', 10:05:00 INFO - 'TMPDIR': '/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/', 10:05:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:05:00 INFO - 'USER': 'cltbld', 10:05:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:05:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:05:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:00 INFO - 'XPC_FLAGS': '0x0', 10:05:00 INFO - 'XPC_SERVICE_NAME': '0', 10:05:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:05:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:01 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)) 10:05:01 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)) 10:05:01 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)) 10:05:01 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)) 10:05:01 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)) 10:05:01 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)) 10:05:01 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)) 10:05:01 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)) 10:05:01 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)) 10:05:01 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)) 10:05:01 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)) 10:05:01 INFO - Cleaning up... 10:05:01 INFO - Return code: 0 10:05:01 INFO - Running post-action listener: _resource_record_post_action 10:05:01 INFO - Running post-action listener: _start_resource_monitoring 10:05:01 INFO - Starting resource monitoring. 10:05:01 INFO - ##### 10:05:01 INFO - ##### Running install step. 10:05:01 INFO - ##### 10:05:01 INFO - Running pre-action listener: _resource_record_pre_action 10:05:01 INFO - Running main action method: install 10:05:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:05:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:05:01 INFO - Reading from file tmpfile_stdout 10:05:01 INFO - Detecting whether we're running mozinstall >=1.0... 10:05:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:05:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:05:01 INFO - Reading from file tmpfile_stdout 10:05:01 INFO - Output received: 10:05:01 INFO - Usage: mozinstall [options] installer 10:05:01 INFO - Options: 10:05:01 INFO - -h, --help show this help message and exit 10:05:01 INFO - -d DEST, --destination=DEST 10:05:01 INFO - Directory to install application into. [default: 10:05:01 INFO - "/builds/slave/test"] 10:05:01 INFO - --app=APP Application being installed. [default: firefox] 10:05:01 INFO - mkdir: /builds/slave/test/build/application 10:05:01 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'] 10:05:01 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 10:05:31 INFO - Reading from file tmpfile_stdout 10:05:31 INFO - Output received: 10:05:31 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:05:31 INFO - Running post-action listener: _resource_record_post_action 10:05:31 INFO - ##### 10:05:31 INFO - ##### Running run-tests step. 10:05:31 INFO - ##### 10:05:31 INFO - Running pre-action listener: _resource_record_pre_action 10:05:31 INFO - Running main action method: run_tests 10:05:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:05:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:05:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:05:31 INFO - 2015-11-18 10:05:31.858 screenresolution[1657:14172] starting screenresolution argv=screenresolution get 10:05:31 INFO - 2015-11-18 10:05:31.860 screenresolution[1657:14172] Display 0: 1600x1200x32@60 10:05:31 INFO - 2015-11-18 10:05:31.866 screenresolution[1658:14174] starting screenresolution argv=screenresolution list 10:05:31 INFO - Available Modes on Display 0 10:05:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:05:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:05:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:05:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:05:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:05:32 INFO - Intel Iris: 10:05:32 INFO - Chipset Model: Intel Iris 10:05:32 INFO - Type: GPU 10:05:32 INFO - Bus: Built-In 10:05:32 INFO - VRAM (Dynamic, Max): 1536 MB 10:05:32 INFO - Vendor: Intel (0x8086) 10:05:32 INFO - Device ID: 0x0a2e 10:05:32 INFO - Revision ID: 0x0009 10:05:32 INFO - Displays: 10:05:32 INFO - Display: 10:05:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:05:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:05:32 INFO - Display Serial Number: 1600x1200 60 10:05:32 INFO - Main Display: Yes 10:05:32 INFO - Mirror: Off 10:05:32 INFO - Online: Yes 10:05:32 INFO - Rotation: Supported 10:05:32 INFO - Return code: 0 10:05:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:05:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:05:32 INFO - Python 2.7.3 10:05:32 INFO - Return code: 0 10:05:32 INFO - grabbing minidump binary from tooltool 10:05: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')]} 10:05:32 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 0x10b8b39f0>, '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 0x10b612db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8a68c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:05:32 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 10:05:32 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 10:05:32 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:05:32 INFO - Return code: 0 10:05:32 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:05:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:05:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:05:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:05:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:05:32 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/H0ZS5RUcQU6LaCIHt42nUA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0022', '--webServer', 'localhost'] in /builds/slave/test/build 10:05:32 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/H0ZS5RUcQU6LaCIHt42nUA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0022 --webServer localhost 10:05:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YOB6E0GDyM/Render', 10:05:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:05:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:05:32 INFO - 'HOME': '/Users/cltbld', 10:05:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:05:32 INFO - 'LOGNAME': 'cltbld', 10:05:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:05:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:05:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:32 INFO - 'MOZ_NO_REMOTE': '1', 10:05:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:05:32 INFO - 'NO_EM_RESTART': '1', 10:05:32 INFO - 'PAGER': '/bin/cat', 10:05:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:05:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:32 INFO - 'PWD': '/builds/slave/test', 10:05:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:05:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:05:32 INFO - 'SHELL': '/bin/bash', 10:05:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.y7jawezWp7/Listeners', 10:05:32 INFO - 'TMPDIR': '/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/', 10:05:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:05:32 INFO - 'USER': 'cltbld', 10:05:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:05:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:05:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:32 INFO - 'XPC_FLAGS': '0x0', 10:05:32 INFO - 'XPC_SERVICE_NAME': '0', 10:05:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:05:32 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/H0ZS5RUcQU6LaCIHt42nUA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0022', '--webServer', 'localhost'] with output_timeout 3600 10:05:32 INFO - mozversion INFO | application_buildid: 20151118081929 10:05:32 INFO - mozversion INFO | application_changeset: 43075970a44ea086084135bb0a100245ecb3bde7 10:05:32 INFO - mozversion INFO | application_display_name: Nightly 10:05:32 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:05:32 INFO - mozversion INFO | application_name: Firefox 10:05:32 INFO - mozversion INFO | application_remotingname: firefox 10:05:32 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 10:05:32 INFO - mozversion INFO | application_vendor: Mozilla 10:05:32 INFO - mozversion INFO | application_version: 45.0a1 10:05:32 INFO - mozversion INFO | platform_buildid: 20151118081929 10:05:32 INFO - mozversion INFO | platform_changeset: 43075970a44ea086084135bb0a100245ecb3bde7 10:05:32 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 10:05:32 INFO - mozversion INFO | platform_version: 45.0a1 10:05:32 INFO - 2015-11-18 10:05:32,415 DEBUG : using testdate: 1447869932 10:05:32 INFO - 2015-11-18 10:05:32,415 DEBUG : actual date: 1447869932 10:05:32 INFO - 2015-11-18 10:05:32,853 INFO : starting webserver on 'localhost:49269' 10:05:32 INFO - 2015-11-18 10:05:32,854 INFO : Starting test suite t-yosemite-r7-0022 10:05:32 INFO - 2015-11-18 10:05:32,854 INFO : Starting test dromaeo_css 10:05:32 INFO - 2015-11-18 10:05:32,855 DEBUG : operating with platform_type : mac_ 10:05:32 INFO - 2015-11-18 10:05:32,856 INFO : Initialising browser for dromaeo_css test... 10:05:32 INFO - 2015-11-18 10:05:32,868 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/tmphEqi2z/profile http://localhost:49269/getInfo.html 10:05:35 INFO - 2015-11-18 10:05:35,147 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:05:35 INFO - 2015-11-18 10:05:35,147 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:05:35 INFO - 2015-11-18 10:05:35,147 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 10:05:35 INFO - 2015-11-18 10:05:35,147 DEBUG : BROWSER_OUTPUT: __metrics 10:05:35 INFO - 2015-11-18 10:05:35,163 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:05:35 INFO - 2015-11-18 10:05:35,423 DEBUG : BROWSER_OUTPUT: console.error: 10:05:35 INFO - 2015-11-18 10:05:35,424 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 10:05:35 INFO - 2015-11-18 10:05:35,424 DEBUG : BROWSER_OUTPUT: Stack: 10:05:35 INFO - 2015-11-18 10:05:35,424 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 10:05:35 INFO - 2015-11-18 10:05:35,424 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 10:05:35 INFO - 2015-11-18 10:05:35,424 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 10:05:35 INFO - 2015-11-18 10:05:35,424 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 10:05:35 INFO - 2015-11-18 10:05:35,424 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 10:05:35 INFO - 2015-11-18 10:05:35,424 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 10:05:35 INFO - 2015-11-18 10:05:35,424 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 10:05:35 INFO - 2015-11-18 10:05:35,424 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 10:05:35 INFO - 2015-11-18 10:05:35,425 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 10:05:35 INFO - 2015-11-18 10:05:35,425 DEBUG : BROWSER_OUTPUT: 10:05:35 INFO - 2015-11-18 10:05:35,830 INFO : Browser initialized. 10:05:35 INFO - 2015-11-18 10:05:35,830 INFO : Running cycle 1/1 for dromaeo_css test... 10:05:35 INFO - 2015-11-18 10:05:35,830 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/tmphEqi2z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:05:47 INFO - 2015-11-18 10:05:47,624 DEBUG : BROWSER_OUTPUT: RSS: Main: 224632832 10:05:47 INFO - 2015-11-18 10:05:47,624 DEBUG : BROWSER_OUTPUT: 10:06:44 INFO - 2015-11-18 10:06:44,795 DEBUG : BROWSER_OUTPUT: 1447870004795 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] 10:08:49 INFO - 2015-11-18 10:08:49,823 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49269/tests/dromaeo/cssquery-ext.html) 10:08:51 INFO - 2015-11-18 10:08:51,150 DEBUG : BROWSER_OUTPUT: RSS: Main: 359071744 10:08:51 INFO - 2015-11-18 10:08:51,150 DEBUG : BROWSER_OUTPUT: 10:11:53 INFO - 2015-11-18 10:11:53,922 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-ext.html (next: http://localhost:49269/tests/dromaeo/cssquery-jquery.html) 10:11:54 INFO - 2015-11-18 10:11:54,506 DEBUG : BROWSER_OUTPUT: RSS: Main: 363409408 10:11:54 INFO - 2015-11-18 10:11:54,506 DEBUG : BROWSER_OUTPUT: 10:14:56 INFO - 2015-11-18 10:14:56,603 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49269/tests/dromaeo/cssquery-mootools.html) 10:14:57 INFO - 2015-11-18 10:14:57,192 DEBUG : BROWSER_OUTPUT: RSS: Main: 360321024 10:14:57 INFO - 2015-11-18 10:14:57,192 DEBUG : BROWSER_OUTPUT: 10:17:59 INFO - 2015-11-18 10:17:59,292 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49269/tests/dromaeo/cssquery-prototype.html) 10:17:59 INFO - 2015-11-18 10:17:59,871 DEBUG : BROWSER_OUTPUT: RSS: Main: 319184896 10:17:59 INFO - 2015-11-18 10:17:59,871 DEBUG : BROWSER_OUTPUT: 10:21:02 INFO - 2015-11-18 10:21:02,820 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49269/tests/dromaeo/cssquery-yui.html) 10:21:03 INFO - 2015-11-18 10:21:03,412 DEBUG : BROWSER_OUTPUT: RSS: Main: 326836224 10:21:03 INFO - 2015-11-18 10:21:03,413 DEBUG : BROWSER_OUTPUT: 10:24:06 INFO - 2015-11-18 10:24:06,154 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-yui.html (next: http://localhost:49269/tests/dromaeo/cssquery-dojo.html) 10:24:06 INFO - 2015-11-18 10:24:06,411 DEBUG : BROWSER_OUTPUT: RSS: Main: 366424064 10:24:06 INFO - 2015-11-18 10:24:06,411 DEBUG : BROWSER_OUTPUT: 10:24:06 INFO - 2015-11-18 10:24:06,411 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:24:06 INFO - 2015-11-18 10:24:06,411 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:24:06 INFO - 2015-11-18 10:24:06,412 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:24:06 INFO - 2015-11-18 10:24:06,412 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:24:06 INFO - 2015-11-18 10:24:06,415 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3413.5562376891003;3497.842597083131;3527.03006673165;3531.699805516531;3548.91127721807;5718.9428105718935;5739.684317362543;5798.391168927265;5800.5649576281785;5801.4198580141965;5795.043817770063;5911.970440147793;5921.585489015771;5933.584649074566;5957.493613042886;5315.627906046579;5351.892962140755;5426.104692725696;5433.673979561239;5443.101888188444;5445.918311225335;5446.645968012086;5450.945490545084;5451.536619387337;5458.699771512565;5361.785528578852;5434.130539113743;5440.6735595864375;5447.319085114361;5447.536959358439;5407.432219616942;5428.240046393508;5432.266644003088;5436.673799572039;5438.864028399282;5273.947260527422;5372.301600791911;5390;5409.648372855791;5412.485813847678;5804.216430781875;5898.321693005273;5933;5962.25471816023;5979.760809567612;6376.489880809524;6379.712912918883;6385.361463853624;6393.264774550893;6405.263394709621;5654.236678048452;6219.2847822500535;6223.813285601439;6400.39196276353;6403.647799371032;5792.102224155263;6055.697215139226;6058.363871793486;6073.242289305543;6078.361772013964;6378.904316435257;6461.515386346043;6463.838404039937;6471.546991710629;6481.578697384655;6082.695865206722;6145.539084568675;6163.660998645118;6176.227971503562;6186.041163619556;6253.499720022387;6280.466160376419;6340.175777148941;6368;6378.17083779115;6304.18045654062;6345.238571371465;6360.809175724736;6361.077643741724;6364.872702546016;6205.6586887720705;6362.045693146065;6373.776917807854;6379.585326953826;6393.424591786761;4932.605391568666;5022.321986531844;5039.798408063636;5068.695878247317;5074.898502029939;4543.091381723669;4543.34121552373;4558.658100642465;4588.816447342136;4600.907981840344;5936.079907614327;5952.821415357546;5953.226080609493;5968.343482216953;5974.312954010257;6209.782657606962;6234.314225435199;6331.0819931110655;6350.936490635127;6368.904466433008;5896.174535565025;5905.645661260252;5917.6745279010065;5924.259467566554;5954.85112872173;5516.282883225155;5526.557875369961;5537.58468114893;5551.167324901297;5554.2779438672715;6265.467435267962;6335.651539165206;6366.108744775735;6378.90431643535;6463.062855885964;6325.399087086719;6360.936390636034;6362.522810789302;6370.108184854217;6388.297287298301;6480.092787009728;6501.187351581052;6514.381133792472;6522.836929076811;6522.836929076811;6135.441059721752;6206.317305096345;6263.123162757127;6267.780627678009;6346.936530634634;5452.836414907559;6155.0151975683675;6308.810735677937;6353.110564521063;6376.011718183689;6238.220222472191;6278.121063051268;6288.528360373082;6290;6306.65313407767;5982.012967860254;6094.114023714709;6107.067445037884;6123.418275263843;6257.499400047895;6147.569670123048;6148.50811935053;6157.876842463036;6163.3836616338;6166.568340216142;6257.2804127525915;6268.435840774352;6280.466160376236;6283.2774230962195;6295.716692748929;5871.559633027455;6002.879942401215;6008.1588577598295;6020.036794112921;6098.162381879712 10:24:06 INFO - 2015-11-18 10:24:06,415 DEBUG : BROWSER_OUTPUT: |1;ext.html;559.8068666310124;570.0594019867222;596.3261514488627;607.9846656084338;631.7220423013871;28197;32361.838190809012;33257.833710831444;42165.156696866085;44819;44806.551934480725;45200.321995170016;45233.09533809322;45249.321260181045;45361;8731.257843083315;9754.365966212192;9931.90068099317;9948.502574871227;9958.452285124315;8848.424852384607;10226.33528820628;12286.569970051005;12289.692757681085;12291.569795057174;11845.17083804134;11953.641390758292;11961.820572691417;11962.10284228682;11968.34174120423;7867.881981770278;8935.553222338922;9056.909430905673;11952.94023529881;12135.08986825987;8863.11368863115;8972.237359824423;11661.067114630809;12023.579174728842;12058.457369418396;40981.59018409807;41220;41380.79309603433;41388.1722365554;41400;3300.47192449207;3390.86436542538;3432.2449061206494;3842.865499707497;3905.5703872573995;30124.8493757532;30276.394472110434;30385.392292154254;30553.93061242868;30616.2345941351;2451.32378439876;2555.6166575013713;2565.204786516167;2655.803671228778;2745.3822889849826;504268;505252;505480.99999999633;506792;507829;61579.38420615826;62483.06275405872;62928.11215663446;69107.65446172738;69751;61415.07877381843;61624.69187654033;73750;74973.625131874;75081.6245918767;16623.6675266494;16640.084795336374;16814.15929203535;16814.663706725798;16852.57868553296;12800.231986080866;12851.550195743104;12855.614331570068;12861.614151575468;12886.80669789954;17294.740578891327;21188.15247390087;21318.893405532872;21410.89294553517;21420.250291240045;8936.597853096626;9051.456912585134;9057.954710226539;9065.41074830134;9184.90815091854;824.6948629007305;917.5824999625155;1018.7758693087509;1119.3004372267333;1177.1877404590805;28254.71745282562;30191.698083019328;30227.395452090834;30957.535636965462;30968.69031309703;1089.9237053406343;1094.1465656787718;1098;1173.85913690356;1190.4880901212562;14466.349014294383;14520.491782787763;14594.927025364805;14919.850801491846;14946.92526537382;458273;462774.744505108;463422;464537;464799;56949.43050569524;57228.713856431285;57233.42766572281;57288.713556431954;57433.71283143641;1460.4158336665419;1479.297333766474;1480.1489143742606;1493.843146469605;1501.0543357684808;23225.535489290458;27135.914563417242;28575.28561785972;29379.118626441243;30888;53227;53674.194887075944;53690.46309536855;53712.462875370744;53741;404890;405941.97029014665;405985.97007014777;406122;406846;29984.550231746103;30735.2316192097;32954.67045329516;34146.146346340545;34957.65042349544;43362.78318608513;43819.34270985874;43889.78055109704;44016.55983440253;44371.33442998293;36538.26923461463;36620.63379366172;37358.75847449053;37437.62562374341;37738;28955.573848187614;30874.91937782167;35784.642153578134;37903.43144852774;38925.6107438922;36653.45019824758;37378.06554836151;38309.808450957564;38382.61617383902;38429.4235586472;31454.84272578714;33592.49611255882;33818.41725185478;33909.49135762916;34115.14712132217;24895.626565601167;24972.50054998926;25140.62289065629;25387;25416.618750719124 10:24:06 INFO - 2015-11-18 10:24:06,418 DEBUG : BROWSER_OUTPUT: |2;jquery.html;351.3640311037023;356.84120566347974;358.1976372924646;362.6228722128987;364.9817509124543;15867.365305387772;16136.919315403407;19430.028498575066;20200.98995050247;20850.748955062707;16728.41450549228;19248.23007079715;20828.375148745523;21278.468038299052;21307.68038479424;5707.400722924085;5967;5984.910226346608;5993;6013.037913933771;4244.660427165819;4381.3647021181905;5952.9107063394085;5997.970010149965;6000.489958353545;6021.488173505235;6471.708773105222;6473.902891456609;6476.481881449473;6487.318831522669;6303.747850085991;6433.9678301608665;6437.452816510602;6445.065465507499;6450.290468048511;5594.216809646653;5597.552195824324;5608.551315894719;5616.213730077792;5620.662760234399;25608.48783024329;25717.228483145536;25883.223503294932;26091.956321747108;26194;1857.3777784442093;1949.87325823821;1951.4828570428847;1989.2838578111869;2304.493011537459;8438.831223375499;10152.238582106298;10221.437820919846;10428.79142417155;10714.624988125379;1628.6742651469754;1630.3071194742188;1631.844974727399;1683.781108455905;1684;92684.53657731735;96130.0386996128;97832.51083744607;97939.51030244875;98481;5797.913031304533;6901.102856628606;6929.549579277432;6986.9650651746415;6997.790066298019;7932.524048557105;7937;7948.960255198803;7952.642131104114;7989.56057416836;5838;5862.589618726648;5878.382769809108;5915.526757859361;5919.792807251725;6295.150154729145;6304.968475157687;6347.460465860361;6357.650329231937;6372.426481616677;2669;2719.2386131883104;3035.9374219023166;3083.5066389377594;3105.503119500869;1073.3774410841693;1079.5897558927713;1114.5764609448358;1116.1071143085499;1165.4289398194824;410.86236110902587;414.1241274703979;434.75653633965084;480.9278608208797;504.04231959277666;12363.505459781687;12482.875171248172;12969.092163548461;12972.481100756053;13002.414891329912;390.63865924020166;419.88033410478477;475.7074399244509;490.1911845455028;508.8829569199105;4779.808807647724;6676.9666151668935;6924.826879327957;6985.930140698528;7056.188538318159;789712;791468;809853;810211;816368;99098.50450747844;123694;123775;125234.3738281321;126385.36807316089;533.9626226164208;553.5129086403939;555.2420945409567;557.83543854563;558.8826346467288;9769.511524423608;11782.587609433629;11890.643280701594;11982.880171198525;11991.940040299743;48991.75504122599;49117.75441122772;50000;53489.19766203432;53555.393338199916;68745.65627171833;69112;69818.30181698118;69937.30062699308;70717.29282707107;6397.712102955471;6504.60972341661;6573;6579.440747536513;6587.440067594308;12269.93865030669;12584.622461326175;12658.11393202467;12679.80980285315;12681.873181268069;9349.205317548085;9755.463449510062;10165.542550585093;10759.139268858316;10867.076298514714;10735.570577176826;10745.838812417664;10877.67366978992;10892.509837057192;11172.441377931233;10965.780684386427;11212.495437705486;11315.321080735182;11420;11421.543138274375;5898.587098903035;6438.323975982642;6478.384553467413;6503.479721622353;6624.403803657694;11005.284656497302;11144.554217831195;11328;11338.319700817978;11345.602903898323 10:24:06 INFO - 2015-11-18 10:24:06,419 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1626.7397216445368;1697.278656570957;1909.8949557774317;1946.1997652171738;1993.521554826841;7567.091948966125;7955.244251796077;8257.339412846974;8451.788705282372;8468.491890486575;8212.671493140282;8333.374996875229;8372.874406883886;8374.288185504225;8379.790505237372;2129.7763734807854;2176.967345489811;2351.0243249051664;2369.0168580039262;2372.229025566689;2378.3102900158933;2418.22616762636;2419.237940048879;2419.842710223839;2426.0538390027905;2325.6744055832196;2375.0499800079933;2380.5357955198742;2393.5930891748444;2401.5677178107935;2131.968020479694;2184.224600266898;2188;2312.7802858728396;2316.652502124678;2368.14746691191;2375.10933399975;2375.7149142102885;2377.9286621401384;2379;8273.296769774577;8357.331413486967;8370.916290837136;8386.496810191407;8404.705835295796;5101.489851014906;5176.0683077046115;5188.066148093341;5219.6085293602755;5254.97372513135;3498.6326435724136;3522.6125126236093;3595.874144404959;3602.603713591503;3606.296772129436;1058.2750815691277;1059.4014381874217;1082.577794660083;1088.434014312553;1090.907272881806;11127.944360278228;11147.386893720843;11165.776684466346;11167;11194.608188713355;4647.094199333051;4683.110209060268;4688.9296660549435;4717.339572459859;4754.548317909793;9721.368111072758;9723.416595004323;9729.951350243346;9750.463724495221;9769.120779129913;5146.125158723026;5260.736963151827;5262.842114736487;5268.051750684914;5268.4994925482015;4747.905041899143;4752.643551733634;4756.405449318835;4757.405324334458;4791.137595232892;3870.632289932452;3891.6497515223764;3897.629725176104;3932.7050471214775;3942.9605703942593;1268.7652784234947;1273.0770191611007;1276.5468258768003;1282.2050328796206;1292.3086148910288;1299.7205600795874;1336.4520546575857;1344.213635023522;1349.912255703376;1364.501956785786;7772.805679858049;7933.404994625311;7952.284294413531;7962;7963.681452741941;489.3516091179202;497.35344052731307;500.4520050544648;500.58951659639473;506.4606194402949;5975;6127.479164271087;6127.571070025145;6205.317415084337;6411.455026322721;9831.311808173503;9958.452285124387;10019.699409017741;10144.949275253577;10170.847437288447;9916.553755081039;9917.851232231378;9932.652357167464;10003.199744020461;10032.69901902944;7770.10643775973;7808.726694565663;7845.548573513918;7852.882206766903;7874.6850125994315;7833.608319584112;7857.724979625686;7859.646315915683;7859.724909628136;7861.646225919733;8718.302535796995;8776.605052772768;8958.656201569816;9040.773980650274;9075.364724469224;9085.954570227106;9371;9464.290178236522;9474.668386606436;9479.905200947902;7878.881816772639;7968.322692571196;7969.681212751425;7978.481398709066;7991.24083212094;7787.987561616954;7997.240262175084;8044.2760151586635;8046.919530804617;8053.637586308513;7483.064616922885;7519.436042296959;7582.507137036075;7677.462577619736;7680.846383072419;7234.312740289664;7307.7807665770115;7312.488125831141;7477.513961592479;7520.323170914644;7429.665665045194;7517.511361761468;7574.091109066947;7577.355924746458;7579.696812127453;6853.4859885507785;6907.033015377951;6908.412784913137;6916.412104971134;6919.688614012281;6400.871982560229;6960.443164546926;6974.79075627732;6975.40709039717;6991.265917078634 10:24:06 INFO - 2015-11-18 10:24:06,423 DEBUG : BROWSER_OUTPUT: |4;prototype.html;315.95102759072347;322.2121911925342;329.0687354785955;332.8285932744637;333.83642015412454;6764.255931847493;6868.484863635234;6877.965610171948;6884.3115688431135;6905.205901321349;5660.264165658458;6726.798196054114;6796.082528858615;6816.7954961351115;6823.829404264896;5034.5468907798295;5081.644284900059;5084.339035925324;5084.949150508484;5086.364204474441;4956.1822299320565;5062.519060689228;5093.745312734367;5102.846914592549;5110.259012443194;5056.367954005749;5063.240513922904;5082.390113186423;5083.085044691954;5113.181890897457;5039.193729003378;5049.67177133487;5054.267131265946;5062.670926389773;5075.213341931988;4144.088300573869;4229.323308270693;4243.448351714288;4318.201132790444;4341.131773645284;6413.871722565569;6521.576097553644;6569.244536878225;6600.702968366435;6632.137822083147;5956.195913551658;5973.492253158487;5974.641521508724;5979.22270104888;5980.760769569212;5737.88524229513;7254.492185547014;7305.639405873305;7330.413566914634;7332;4804.807807687688;4808.543188397097;4812.061647978646;4819.783109760069;4825.4933232010835;7678.692852285902;7708.807279817994;7723.729669461598;7726;7748.18644042373;4720.905581888343;4852.2479015752615;4895.437024742129;4896.2655601660035;4903.926441103386;4994.1759609663995;4995.325631039836;5005.924911126336;5009.824656137091;5011.874703132378;4863.489333619989;5914.172015917775;5929.140274660236;5941.940580594225;5959.076343166729;7300.196978332379;7312.488125831247;7328.706851725978;7336.376408005272;7436.851262974818;1665.267282395742;1740.617064245864;1751.0019289005145;1756.5257380507192;1761.5860272835873;1127.7293449572044;1134.5858761551974;1135.432283858071;1138.0269869261663;1149.6204554534593;6902.137232845895;6912.239653638096;6928.515003949776;6928.965355173192;6953.096097507393;7626.923730762733;7639.847203055908;7655.272749088827;7656.655450504741;7685.154632990367;6685.364890335411;6878.65606719662;6889.242183359826;6919.100516932867;6931.306869313129;3947.9802600987387;4040.0303927057294;4045.2516284487465;4071.816768245436;4075.7962101894786;7877.645505952131;7888.40836937232;7944.165862584461;8008.239217274349;8016.278534931884;7925.247101525461;7949.364050875916;7981.640826162837;7981.72063977758;7999.800004999922;7724.8455030900195;7977.880331795028;7985.361171106298;8001.799955001172;8006.879896801553;7658.655360508902;7679.385649147943;7685.538867667958;7685.769426917202;7705.653245604073;7386.372158366599;7548.962255188689;7549.0941087069905;7555.8866616999685;7583.27958843909;8043.115257321573;8050.83898322042;8053.872457855788;8056.919430805617;8069.919300807152;4776.617870570277;4813.879653008703;4814.614830813456;4826.251930950708;4836.733979631154;6249.96875015622;7467.402607791472;7700;7734.7679569613;7757.146713861358;7413.592252425952;7417.443691723034;7418.888716669362;7424.554526728413;7424.591647459441;7193.928060719326;7363.852722945404;7380.704771809067;7388.113426388652;7399.112106547249;7214.927850721426;7237.565746055254;7247.927520724726;7250.709971601077;7253.528520646141;6030.396960303934;7396.889046664197;7402.814929626802;7418.072740907387;7419;7042.22535521082;7256.1655409628565;7277.126744790659;7284.235155308616;7303.780886573411 10:24:06 INFO - 2015-11-18 10:24:06,424 DEBUG : BROWSER_OUTPUT: |5;yui.html;725.256611972728;767.735131379674;799.7081065411127;816.6121092481076;841.3017195727539;14998.77501837472;15355.539333819976;15358.232088395564;15366.769498457505;15386.846131538681;14145.575632731008;14358.569242922704;14365.138091714478;14372.784408233885;14373.281335933214;738.4314078159814;747.5365273530391;752.4093586534572;904.5070436612045;924.0251534630962;916.9954150229239;917.9449233046005;930.0931591698107;930.9348345615809;930.972070837876;765.9272369124924;991.9156871665917;994.7264502261863;995.8854731705837;999.0708640963901;772.75658167677;785.3010820369875;962.3888830592554;981.9263555233315;983.5868935047297;736.1571001203592;738.3686947659727;738.4572339330588;739.1868944161433;739.9408047356198;14962.850371496363;15176.696466070616;15197.392104315813;15212.315445804965;15304.311305991258;10289.279750417474;12254;12461.813072803916;12607.873921260762;12701.872981270162;9857.507124643811;10233.948830255875;10244.74388140295;10250.589976400935;10266.178705703525;3477.9826100869586;3530.082178633548;3531.858725650971;3537.6992955598803;3544.7341449391397;77685.61157194234;78203;80056.19943800545;80576.59711701462;80870;9485.75399583041;9571.28215383849;9728.17310528613;9815.647214906596;9876.358036727734;21709.67435488469;21730.78269217319;21744;21745.912704365033;21807;7456.7762967111075;7496.587687677121;7547.924520754722;7599.848003040019;7687.654055567513;3991.5409727881083;4043.73715708478;4065.6950728695465;4065.837366505307;4080.5103387593085;3541.29174165168;3578.6421357864006;3583.4087375582735;3585.1933315003917;3588.2823435313044;535.9732013399314;547.698765678883;563.0540691638006;564.0552075273899;565.541911052041;437.83362322317953;485.7619766314551;553.8839238933552;624.9812505624839;646.360103497534;8464.32285417165;9239.676611318571;9286.67496637628;9345.392549484262;9587;479.72895314147394;531.0759278854842;592.4667798980865;624.4192900602484;663.0419044480775;3708.851645934132;3747.887563373103;3811.213591511233;4005.2790497710694;4172.812223449952;81547;102124.48937755264;102767;102852;103837.48081259546;84789;85421;86495.1350486487;86887;88183;59776.402235977956;76754.61622691852;76917.61541192258;77014;77280;8275.917240827515;8335.333173345996;8419.579021049045;8533.957330213309;8553;53463;53482.73258633682;53872;53974.460255396945;55384.169237460665;70764.64617676879;71132;71216.28783712097;77274.84087738577;77468.45063098594;7604.733834315773;7628.771136865903;7642.694292228471;7677.654505547375;7716.498427602188;9725.0761177688;11055.889441105486;11289.37908415045;11330.150238731963;11468.4265786712;10761.838572421577;10924.344539327349;11090.5563777448;11096;11349.375784331942;9580.568874400808;10319.122874555747;10797.892021079688;10826.621068262573;10886.346819190874;10558.524866380878;10593.311434756715;10652.360858348524;10705.143588513056;10889.727756806144;9058.36591438593;9187.219086377732;9197.540122993958;9431.95284023603;9633.951830241085;9307.348485606213;9322.114399132071;9421.29340299494;9576.324976197966;9614.567344469377 10:24:06 INFO - 2015-11-18 10:24:06,425 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:24:06 INFO - 2015-11-18 10:24:06,425 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:24:06 INFO - 2015-11-18 10:24:06,425 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1106 10:24:06 INFO - 2015-11-18 10:24:06,425 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:24:06 INFO - 2015-11-18 10:24:06,425 DEBUG : BROWSER_OUTPUT: __startTimestamp1447871046410__endTimestamp 10:24:06 INFO - 2015-11-18 10:24:06,425 DEBUG : BROWSER_OUTPUT: 10:24:06 INFO - 2015-11-18 10:24:06,425 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:24:06 INFO - 2015-11-18 10:24:06,425 DEBUG : BROWSER_OUTPUT: Number of tests: 6 10:24:06 INFO - 2015-11-18 10:24:06,425 DEBUG : BROWSER_OUTPUT: 10:24:06 INFO - 2015-11-18 10:24:06,426 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5881.88 Median:6082.70 stddev:621.71 (10.2%) stddev-sans-first:592.70 10:24:06 INFO - 2015-11-18 10:24:06,426 DEBUG : BROWSER_OUTPUT: Values: 3413.6 3497.8 3527.0 3531.7 3548.9 5718.9 5739.7 5798.4 5800.6 5801.4 5795.0 5912.0 5921.6 5933.6 5957.5 5315.6 5351.9 5426.1 5433.7 5443.1 5445.9 5446.6 5450.9 5451.5 5458.7 5361.8 5434.1 5440.7 5447.3 5447.5 5407.4 5428.2 5432.3 5436.7 5438.9 5273.9 5372.3 5390.0 5409.6 5412.5 5804.2 5898.3 5933.0 5962.3 5979.8 6376.5 6379.7 6385.4 6393.3 6405.3 5654.2 6219.3 6223.8 6400.4 6403.6 5792.1 6055.7 6058.4 6073.2 6078.4 6378.9 6461.5 6463.8 6471.5 6481.6 6082.7 6145.5 6163.7 6176.2 6186.0 6253.5 6280.5 6340.2 6368.0 6378.2 6304.2 6345.2 6360.8 6361.1 6364.9 6205.7 6362.0 6373.8 6379.6 6393.4 4932.6 5022.3 5039.8 5068.7 5074.9 4543.1 4543.3 4558.7 4588.8 4600.9 5936.1 5952.8 5953.2 5968.3 5974.3 6209.8 6234.3 6331.1 6350.9 6368.9 5896.2 5905.6 5917.7 5924.3 5954.9 5516.3 5526.6 5537.6 5551.2 5554.3 6265.5 6335.7 6366.1 6378.9 6463.1 6325.4 6360.9 6362.5 6370.1 6388.3 6480.1 6501.2 6514.4 6522.8 6522.8 6135.4 6206.3 6263.1 6267.8 6346.9 5452.8 6155.0 6308.8 6353.1 6376.0 6238.2 6278.1 6288.5 6290.0 6306.7 5982.0 6094.1 6107.1 6123.4 6257.5 6147.6 6148.5 6157.9 6163.4 6166.6 6257.3 6268.4 6280.5 6283.3 6295.7 5871.6 6002.9 6008.2 6020.0 6098.2 10:24:06 INFO - 2015-11-18 10:24:06,426 DEBUG : BROWSER_OUTPUT: 10:24:06 INFO - 2015-11-18 10:24:06,426 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:61477.19 Median:36161.46 stddev:121943.30 (337.2%) stddev-sans-first:122199.61 10:24:06 INFO - 2015-11-18 10:24:06,427 DEBUG : BROWSER_OUTPUT: Values: 559.8 570.1 596.3 608.0 631.7 28197.0 32361.8 33257.8 42165.2 44819.0 44806.6 45200.3 45233.1 45249.3 45361.0 8731.3 9754.4 9931.9 9948.5 9958.5 8848.4 10226.3 12286.6 12289.7 12291.6 11845.2 11953.6 11961.8 11962.1 11968.3 7867.9 8935.6 9056.9 11952.9 12135.1 8863.1 8972.2 11661.1 12023.6 12058.5 40981.6 41220.0 41380.8 41388.2 41400.0 3300.5 3390.9 3432.2 3842.9 3905.6 30124.8 30276.4 30385.4 30553.9 30616.2 2451.3 2555.6 2565.2 2655.8 2745.4 504268.0 505252.0 505481.0 506792.0 507829.0 61579.4 62483.1 62928.1 69107.7 69751.0 61415.1 61624.7 73750.0 74973.6 75081.6 16623.7 16640.1 16814.2 16814.7 16852.6 12800.2 12851.6 12855.6 12861.6 12886.8 17294.7 21188.2 21318.9 21410.9 21420.3 8936.6 9051.5 9058.0 9065.4 9184.9 824.7 917.6 1018.8 1119.3 1177.2 28254.7 30191.7 30227.4 30957.5 30968.7 1089.9 1094.1 1098.0 1173.9 1190.5 14466.3 14520.5 14594.9 14919.9 14946.9 458273.0 462774.7 463422.0 464537.0 464799.0 56949.4 57228.7 57233.4 57288.7 57433.7 1460.4 1479.3 1480.1 1493.8 1501.1 23225.5 27135.9 28575.3 29379.1 30888.0 53227.0 53674.2 53690.5 53712.5 53741.0 404890.0 405942.0 405986.0 406122.0 406846.0 29984.6 30735.2 32954.7 34146.1 34957.7 43362.8 43819.3 43889.8 44016.6 44371.3 36538.3 36620.6 37358.8 37437.6 37738.0 28955.6 30874.9 35784.6 37903.4 38925.6 36653.5 37378.1 38309.8 38382.6 38429.4 31454.8 33592.5 33818.4 33909.5 34115.1 24895.6 24972.5 25140.6 25387.0 25416.6 10:24:06 INFO - 2015-11-18 10:24:06,427 DEBUG : BROWSER_OUTPUT: 10:24:06 INFO - 2015-11-18 10:24:06,427 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:38349.40 Median:24740.97 stddev:132339.44 (534.9%) stddev-sans-first:132679.92 10:24:06 INFO - 2015-11-18 10:24:06,429 DEBUG : BROWSER_OUTPUT: Values: 351.4 356.8 358.2 362.6 365.0 15867.4 16136.9 19430.0 20201.0 20850.7 16728.4 19248.2 20828.4 21278.5 21307.7 5707.4 5967.0 5984.9 5993.0 6013.0 4244.7 4381.4 5952.9 5998.0 6000.5 6021.5 6471.7 6473.9 6476.5 6487.3 6303.7 6434.0 6437.5 6445.1 6450.3 5594.2 5597.6 5608.6 5616.2 5620.7 25608.5 25717.2 25883.2 26092.0 26194.0 1857.4 1949.9 1951.5 1989.3 2304.5 8438.8 10152.2 10221.4 10428.8 10714.6 1628.7 1630.3 1631.8 1683.8 1684.0 92684.5 96130.0 97832.5 97939.5 98481.0 5797.9 6901.1 6929.5 6987.0 6997.8 7932.5 7937.0 7949.0 7952.6 7989.6 5838.0 5862.6 5878.4 5915.5 5919.8 6295.2 6305.0 6347.5 6357.7 6372.4 2669.0 2719.2 3035.9 3083.5 3105.5 1073.4 1079.6 1114.6 1116.1 1165.4 410.9 414.1 434.8 480.9 504.0 12363.5 12482.9 12969.1 12972.5 13002.4 390.6 419.9 475.7 490.2 508.9 4779.8 6677.0 6924.8 6985.9 7056.2 789712.0 791468.0 809853.0 810211.0 816368.0 99098.5 123694.0 123775.0 125234.4 126385.4 534.0 553.5 555.2 557.8 558.9 9769.5 11782.6 11890.6 11982.9 11991.9 48991.8 49117.8 50000.0 53489.2 53555.4 68745.7 69112.0 69818.3 69937.3 70717.3 6397.7 6504.6 6573.0 6579.4 6587.4 12269.9 12584.6 12658.1 12679.8 12681.9 9349.2 9755.5 10165.5 10759.1 10867.1 10735.6 10745.8 10877.7 10892.5 11172.4 10965.8 11212.5 11315.3 11420.0 11421.5 5898.6 6438.3 6478.4 6503.5 6624.4 11005.3 11144.6 11328.0 11338.3 11345.6 10:24:06 INFO - 2015-11-18 10:24:06,429 DEBUG : BROWSER_OUTPUT: 10:24:06 INFO - 2015-11-18 10:24:06,429 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5862.09 Median:6051.24 stddev:3045.70 (50.3%) stddev-sans-first:3037.61 10:24:06 INFO - 2015-11-18 10:24:06,430 DEBUG : BROWSER_OUTPUT: Values: 1626.7 1697.3 1909.9 1946.2 1993.5 7567.1 7955.2 8257.3 8451.8 8468.5 8212.7 8333.4 8372.9 8374.3 8379.8 2129.8 2177.0 2351.0 2369.0 2372.2 2378.3 2418.2 2419.2 2419.8 2426.1 2325.7 2375.0 2380.5 2393.6 2401.6 2132.0 2184.2 2188.0 2312.8 2316.7 2368.1 2375.1 2375.7 2377.9 2379.0 8273.3 8357.3 8370.9 8386.5 8404.7 5101.5 5176.1 5188.1 5219.6 5255.0 3498.6 3522.6 3595.9 3602.6 3606.3 1058.3 1059.4 1082.6 1088.4 1090.9 11127.9 11147.4 11165.8 11167.0 11194.6 4647.1 4683.1 4688.9 4717.3 4754.5 9721.4 9723.4 9730.0 9750.5 9769.1 5146.1 5260.7 5262.8 5268.1 5268.5 4747.9 4752.6 4756.4 4757.4 4791.1 3870.6 3891.6 3897.6 3932.7 3943.0 1268.8 1273.1 1276.5 1282.2 1292.3 1299.7 1336.5 1344.2 1349.9 1364.5 7772.8 7933.4 7952.3 7962.0 7963.7 489.4 497.4 500.5 500.6 506.5 5975.0 6127.5 6127.6 6205.3 6411.5 9831.3 9958.5 10019.7 10144.9 10170.8 9916.6 9917.9 9932.7 10003.2 10032.7 7770.1 7808.7 7845.5 7852.9 7874.7 7833.6 7857.7 7859.6 7859.7 7861.6 8718.3 8776.6 8958.7 9040.8 9075.4 9086.0 9371.0 9464.3 9474.7 9479.9 7878.9 7968.3 7969.7 7978.5 7991.2 7788.0 7997.2 8044.3 8046.9 8053.6 7483.1 7519.4 7582.5 7677.5 7680.8 7234.3 7307.8 7312.5 7477.5 7520.3 7429.7 7517.5 7574.1 7577.4 7579.7 6853.5 6907.0 6908.4 6916.4 6919.7 6400.9 6960.4 6974.8 6975.4 6991.3 10:24:06 INFO - 2015-11-18 10:24:06,430 DEBUG : BROWSER_OUTPUT: 10:24:06 INFO - 2015-11-18 10:24:06,431 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:6035.51 Median:6873.23 stddev:1929.95 (28.1%) stddev-sans-first:1887.02 10:24:06 INFO - 2015-11-18 10:24:06,432 DEBUG : BROWSER_OUTPUT: Values: 316.0 322.2 329.1 332.8 333.8 6764.3 6868.5 6878.0 6884.3 6905.2 5660.3 6726.8 6796.1 6816.8 6823.8 5034.5 5081.6 5084.3 5084.9 5086.4 4956.2 5062.5 5093.7 5102.8 5110.3 5056.4 5063.2 5082.4 5083.1 5113.2 5039.2 5049.7 5054.3 5062.7 5075.2 4144.1 4229.3 4243.4 4318.2 4341.1 6413.9 6521.6 6569.2 6600.7 6632.1 5956.2 5973.5 5974.6 5979.2 5980.8 5737.9 7254.5 7305.6 7330.4 7332.0 4804.8 4808.5 4812.1 4819.8 4825.5 7678.7 7708.8 7723.7 7726.0 7748.2 4720.9 4852.2 4895.4 4896.3 4903.9 4994.2 4995.3 5005.9 5009.8 5011.9 4863.5 5914.2 5929.1 5941.9 5959.1 7300.2 7312.5 7328.7 7336.4 7436.9 1665.3 1740.6 1751.0 1756.5 1761.6 1127.7 1134.6 1135.4 1138.0 1149.6 6902.1 6912.2 6928.5 6929.0 6953.1 7626.9 7639.8 7655.3 7656.7 7685.2 6685.4 6878.7 6889.2 6919.1 6931.3 3948.0 4040.0 4045.3 4071.8 4075.8 7877.6 7888.4 7944.2 8008.2 8016.3 7925.2 7949.4 7981.6 7981.7 7999.8 7724.8 7977.9 7985.4 8001.8 8006.9 7658.7 7679.4 7685.5 7685.8 7705.7 7386.4 7549.0 7549.1 7555.9 7583.3 8043.1 8050.8 8053.9 8056.9 8069.9 4776.6 4813.9 4814.6 4826.3 4836.7 6250.0 7467.4 7700.0 7734.8 7757.1 7413.6 7417.4 7418.9 7424.6 7424.6 7193.9 7363.9 7380.7 7388.1 7399.1 7214.9 7237.6 7247.9 7250.7 7253.5 6030.4 7396.9 7402.8 7418.1 7419.0 7042.2 7256.2 7277.1 7284.2 7303.8 10:24:06 INFO - 2015-11-18 10:24:06,432 DEBUG : BROWSER_OUTPUT: 10:24:06 INFO - 2015-11-18 10:24:06,432 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:18907.32 Median:654.70 stddev:27446.99 (4192.3%) stddev-sans-first:27490.04 10:24:06 INFO - 2015-11-18 10:24:06,432 DEBUG : BROWSER_OUTPUT: Values: 725.3 767.7 799.7 816.6 841.3 14998.8 15355.5 15358.2 15366.8 15386.8 14145.6 14358.6 14365.1 14372.8 14373.3 738.4 747.5 752.4 904.5 924.0 917.0 917.9 930.1 930.9 931.0 765.9 991.9 994.7 995.9 999.1 772.8 785.3 962.4 981.9 983.6 736.2 738.4 738.5 739.2 739.9 14962.9 15176.7 15197.4 15212.3 15304.3 10289.3 12254.0 12461.8 12607.9 12701.9 9857.5 10233.9 10244.7 10250.6 10266.2 3478.0 3530.1 3531.9 3537.7 3544.7 77685.6 78203.0 80056.2 80576.6 80870.0 9485.8 9571.3 9728.2 9815.6 9876.4 21709.7 21730.8 21744.0 21745.9 21807.0 7456.8 7496.6 7547.9 7599.8 7687.7 3991.5 4043.7 4065.7 4065.8 4080.5 3541.3 3578.6 3583.4 3585.2 3588.3 536.0 547.7 563.1 564.1 565.5 437.8 485.8 553.9 625.0 646.4 8464.3 9239.7 9286.7 9345.4 9587.0 479.7 531.1 592.5 624.4 663.0 3708.9 3747.9 3811.2 4005.3 4172.8 81547.0 102124.5 102767.0 102852.0 103837.5 84789.0 85421.0 86495.1 86887.0 88183.0 59776.4 76754.6 76917.6 77014.0 77280.0 8275.9 8335.3 8419.6 8534.0 8553.0 53463.0 53482.7 53872.0 53974.5 55384.2 70764.6 71132.0 71216.3 77274.8 77468.5 7604.7 7628.8 7642.7 7677.7 7716.5 9725.1 11055.9 11289.4 11330.2 11468.4 10761.8 10924.3 11090.6 11096.0 11349.4 9580.6 10319.1 10797.9 10826.6 10886.3 10558.5 10593.3 10652.4 10705.1 10889.7 9058.4 9187.2 9197.5 9432.0 9634.0 9307.3 9322.1 9421.3 9576.3 9614.6 10:24:06 INFO - 2015-11-18 10:24:06,432 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:24:06 INFO - 2015-11-18 10:24:06,432 DEBUG : BROWSER_OUTPUT: 10:24:06 INFO - 2015-11-18 10:24:06,908 INFO : Browser exited with error code: 0 10:24:06 INFO - 2015-11-18 10:24:06,932 INFO : Completed test dromaeo_css (00:18:34) 10:24:06 INFO - 2015-11-18 10:24:06,932 INFO : Starting test kraken 10:24:06 INFO - 2015-11-18 10:24:06,932 DEBUG : operating with platform_type : mac_ 10:24:06 INFO - 2015-11-18 10:24:06,932 INFO : Initialising browser for kraken test... 10:24:06 INFO - 2015-11-18 10:24:06,945 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/tmpoIcS14/profile http://localhost:49269/getInfo.html 10:24:08 INFO - 2015-11-18 10:24:08,932 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:24:08 INFO - 2015-11-18 10:24:08,932 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:24:08 INFO - 2015-11-18 10:24:08,932 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 10:24:08 INFO - 2015-11-18 10:24:08,933 DEBUG : BROWSER_OUTPUT: __metrics 10:24:08 INFO - 2015-11-18 10:24:08,940 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:24:09 INFO - 2015-11-18 10:24:09,303 DEBUG : BROWSER_OUTPUT: console.error: 10:24:09 INFO - 2015-11-18 10:24:09,303 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 10:24:09 INFO - 2015-11-18 10:24:09,303 DEBUG : BROWSER_OUTPUT: Stack: 10:24:09 INFO - 2015-11-18 10:24:09,303 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 10:24:09 INFO - 2015-11-18 10:24:09,304 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 10:24:09 INFO - 2015-11-18 10:24:09,304 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 10:24:09 INFO - 2015-11-18 10:24:09,304 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 10:24:09 INFO - 2015-11-18 10:24:09,304 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 10:24:09 INFO - 2015-11-18 10:24:09,304 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 10:24:09 INFO - 2015-11-18 10:24:09,304 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 10:24:09 INFO - 2015-11-18 10:24:09,304 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 10:24:09 INFO - 2015-11-18 10:24:09,305 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 10:24:09 INFO - 2015-11-18 10:24:09,305 DEBUG : BROWSER_OUTPUT: 10:24:09 INFO - 2015-11-18 10:24:09,682 INFO : Browser initialized. 10:24:09 INFO - 2015-11-18 10:24:09,683 INFO : Running cycle 1/1 for kraken test... 10:24:09 INFO - 2015-11-18 10:24:09,683 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/tmpoIcS14/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:24:21 INFO - 2015-11-18 10:24:21,472 DEBUG : BROWSER_OUTPUT: RSS: Main: 225247232 10:24:21 INFO - 2015-11-18 10:24:21,472 DEBUG : BROWSER_OUTPUT: 10:24:24 INFO - 2015-11-18 10:24:24,005 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection) 10:24:24 INFO - 2015-11-18 10:24:24,600 DEBUG : BROWSER_OUTPUT: RSS: Main: 276090880 10:24:24 INFO - 2015-11-18 10:24:24,600 DEBUG : BROWSER_OUTPUT: 10:24:27 INFO - 2015-11-18 10:24:27,188 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-dft) 10:24:27 INFO - 2015-11-18 10:24:27,779 DEBUG : BROWSER_OUTPUT: RSS: Main: 288600064 10:24:27 INFO - 2015-11-18 10:24:27,779 DEBUG : BROWSER_OUTPUT: 10:24:31 INFO - 2015-11-18 10:24:31,141 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-fft) 10:24:31 INFO - 2015-11-18 10:24:31,719 DEBUG : BROWSER_OUTPUT: RSS: Main: 273465344 10:24:31 INFO - 2015-11-18 10:24:31,720 DEBUG : BROWSER_OUTPUT: 10:24:33 INFO - 2015-11-18 10:24:33,582 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator) 10:24:34 INFO - 2015-11-18 10:24:34,164 DEBUG : BROWSER_OUTPUT: RSS: Main: 275877888 10:24:34 INFO - 2015-11-18 10:24:34,164 DEBUG : BROWSER_OUTPUT: 10:24:36 INFO - 2015-11-18 10:24:36,168 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:24:36 INFO - 2015-11-18 10:24:36,747 DEBUG : BROWSER_OUTPUT: RSS: Main: 278409216 10:24:36 INFO - 2015-11-18 10:24:36,747 DEBUG : BROWSER_OUTPUT: 10:24:39 INFO - 2015-11-18 10:24:39,440 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom) 10:24:40 INFO - 2015-11-18 10:24:40,030 DEBUG : BROWSER_OUTPUT: RSS: Main: 278908928 10:24:40 INFO - 2015-11-18 10:24:40,030 DEBUG : BROWSER_OUTPUT: 10:24:42 INFO - 2015-11-18 10:24:42,822 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate) 10:24:43 INFO - 2015-11-18 10:24:43,412 DEBUG : BROWSER_OUTPUT: RSS: Main: 279166976 10:24:43 INFO - 2015-11-18 10:24:43,413 DEBUG : BROWSER_OUTPUT: 10:24:46 INFO - 2015-11-18 10:24:46,277 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial) 10:24:46 INFO - 2015-11-18 10:24:46,869 DEBUG : BROWSER_OUTPUT: RSS: Main: 277659648 10:24:46 INFO - 2015-11-18 10:24:46,869 DEBUG : BROWSER_OUTPUT: 10:24:48 INFO - 2015-11-18 10:24:48,395 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:24:48 INFO - 2015-11-18 10:24:48,976 DEBUG : BROWSER_OUTPUT: RSS: Main: 312201216 10:24:48 INFO - 2015-11-18 10:24:48,976 DEBUG : BROWSER_OUTPUT: 10:24:50 INFO - 2015-11-18 10:24:50,734 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:24:51 INFO - 2015-11-18 10:24:51,356 DEBUG : BROWSER_OUTPUT: RSS: Main: 315387904 10:24:51 INFO - 2015-11-18 10:24:51,356 DEBUG : BROWSER_OUTPUT: 10:24:53 INFO - 2015-11-18 10:24:53,483 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:24:54 INFO - 2015-11-18 10:24:54,075 DEBUG : BROWSER_OUTPUT: RSS: Main: 321568768 10:24:54 INFO - 2015-11-18 10:24:54,075 DEBUG : BROWSER_OUTPUT: 10:24:56 INFO - 2015-11-18 10:24:56,625 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:24:57 INFO - 2015-11-18 10:24:57,219 DEBUG : BROWSER_OUTPUT: RSS: Main: 323137536 10:24:57 INFO - 2015-11-18 10:24:57,219 DEBUG : BROWSER_OUTPUT: 10:24:59 INFO - 2015-11-18 10:24:59,742 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:25:00 INFO - 2015-11-18 10:25:00,345 DEBUG : BROWSER_OUTPUT: RSS: Main: 321871872 10:25:00 INFO - 2015-11-18 10:25:00,345 DEBUG : BROWSER_OUTPUT: 10:25:01 INFO - 2015-11-18 10:25:01,985 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49269/tests/kraken/driver.html?testName=ai-astar) 10:25:02 INFO - 2015-11-18 10:25:02,235 DEBUG : BROWSER_OUTPUT: RSS: Main: 382107648 10:25:02 INFO - 2015-11-18 10:25:02,235 DEBUG : BROWSER_OUTPUT: 10:25:02 INFO - 2015-11-18 10:25:02,235 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:25:02 INFO - 2015-11-18 10:25:02,235 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:25:02 INFO - 2015-11-18 10:25:02,235 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:25:02 INFO - 2015-11-18 10:25:02,236 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:25:02 INFO - 2015-11-18 10:25:02,236 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;110;105;109;110;111;99;110;100;111 10:25:02 INFO - 2015-11-18 10:25:02,236 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;144;118;139;152;118;140;118;153;157;148 10:25:02 INFO - 2015-11-18 10:25:02,237 DEBUG : BROWSER_OUTPUT: |2;audio-dft;180;182;184;185;251;244;187;186;182;183 10:25:02 INFO - 2015-11-18 10:25:02,237 DEBUG : BROWSER_OUTPUT: |3;audio-fft;65;65;74;73;54;58;56;71;74;54 10:25:02 INFO - 2015-11-18 10:25:02,237 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;85;84;119;73;75;76;108;74;75;110 10:25:02 INFO - 2015-11-18 10:25:02,237 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;86;87;86;87;86;86;87;86;86;87 10:25:02 INFO - 2015-11-18 10:25:02,237 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;94;96;94;95;93;95;95;93;94;96 10:25:02 INFO - 2015-11-18 10:25:02,237 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;84;100;134;136;103;85;84;86;84;83 10:25:02 INFO - 2015-11-18 10:25:02,237 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;57;55;55;57;55;56;65;53;55 10:25:02 INFO - 2015-11-18 10:25:02,237 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;64;63;64;64;66;66;65;66;66 10:25:02 INFO - 2015-11-18 10:25:02,237 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;82;82;79;96;105;103;83;82;83 10:25:02 INFO - 2015-11-18 10:25:02,237 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;132;130;120;123;126;119;122;124;123;123 10:25:02 INFO - 2015-11-18 10:25:02,237 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;132;136;138;137;134;124;138;135;166;167 10:25:02 INFO - 2015-11-18 10:25:02,237 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;65;64;64;65;64;65;67;65;64;66 10:25:02 INFO - 2015-11-18 10:25:02,237 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:25:02 INFO - 2015-11-18 10:25:02,238 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:25:02 INFO - 2015-11-18 10:25:02,238 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1029 10:25:02 INFO - 2015-11-18 10:25:02,238 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:25:02 INFO - 2015-11-18 10:25:02,238 DEBUG : BROWSER_OUTPUT: __startTimestamp1447871102234__endTimestamp 10:25:02 INFO - 2015-11-18 10:25:02,238 DEBUG : BROWSER_OUTPUT: 10:25:02 INFO - 2015-11-18 10:25:02,239 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:25:02 INFO - 2015-11-18 10:25:02,239 DEBUG : BROWSER_OUTPUT: Number of tests: 14 10:25:02 INFO - 2015-11-18 10:25:02,240 DEBUG : BROWSER_OUTPUT: 10:25:02 INFO - 2015-11-18 10:25:02,240 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.30 Median:110.00 stddev:4.47 (4.1%) stddev-sans-first:4.74 10:25:02 INFO - 2015-11-18 10:25:02,240 DEBUG : BROWSER_OUTPUT: Values: 108.0 110.0 105.0 109.0 110.0 111.0 99.0 110.0 100.0 111.0 10:25:02 INFO - 2015-11-18 10:25:02,240 DEBUG : BROWSER_OUTPUT: 10:25:02 INFO - 2015-11-18 10:25:02,240 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:138.70 Median:146.00 stddev:15.34 (10.5%) stddev-sans-first:16.15 10:25:02 INFO - 2015-11-18 10:25:02,240 DEBUG : BROWSER_OUTPUT: Values: 144.0 118.0 139.0 152.0 118.0 140.0 118.0 153.0 157.0 148.0 10:25:02 INFO - 2015-11-18 10:25:02,240 DEBUG : BROWSER_OUTPUT: 10:25:02 INFO - 2015-11-18 10:25:02,240 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:196.40 Median:185.50 stddev:27.06 (14.6%) stddev-sans-first:28.04 10:25:02 INFO - 2015-11-18 10:25:02,240 DEBUG : BROWSER_OUTPUT: Values: 180.0 182.0 184.0 185.0 251.0 244.0 187.0 186.0 182.0 183.0 10:25:02 INFO - 2015-11-18 10:25:02,240 DEBUG : BROWSER_OUTPUT: 10:25:02 INFO - 2015-11-18 10:25:02,241 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:64.40 Median:68.00 stddev:8.37 (12.3%) stddev-sans-first:8.87 10:25:02 INFO - 2015-11-18 10:25:02,241 DEBUG : BROWSER_OUTPUT: Values: 65.0 65.0 74.0 73.0 54.0 58.0 56.0 71.0 74.0 54.0 10:25:02 INFO - 2015-11-18 10:25:02,241 DEBUG : BROWSER_OUTPUT: 10:25:02 INFO - 2015-11-18 10:25:02,241 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:87.90 Median:75.00 stddev:17.55 (23.4%) stddev-sans-first:18.59 10:25:02 INFO - 2015-11-18 10:25:02,241 DEBUG : BROWSER_OUTPUT: Values: 85.0 84.0 119.0 73.0 75.0 76.0 108.0 74.0 75.0 110.0 10:25:02 INFO - 2015-11-18 10:25:02,241 DEBUG : BROWSER_OUTPUT: 10:25:02 INFO - 2015-11-18 10:25:02,241 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:86.40 Median:86.50 stddev:0.52 (0.6%) stddev-sans-first:0.53 10:25:02 INFO - 2015-11-18 10:25:02,241 DEBUG : BROWSER_OUTPUT: Values: 86.0 87.0 86.0 87.0 86.0 86.0 87.0 86.0 86.0 87.0 10:25:02 INFO - 2015-11-18 10:25:02,241 DEBUG : BROWSER_OUTPUT: 10:25:02 INFO - 2015-11-18 10:25:02,241 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:94.50 Median:95.00 stddev:1.08 (1.1%) stddev-sans-first:1.13 10:25:02 INFO - 2015-11-18 10:25:02,241 DEBUG : BROWSER_OUTPUT: Values: 94.0 96.0 94.0 95.0 93.0 95.0 95.0 93.0 94.0 96.0 10:25:02 INFO - 2015-11-18 10:25:02,241 DEBUG : BROWSER_OUTPUT: 10:25:02 INFO - 2015-11-18 10:25:02,241 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:97.90 Median:84.00 stddev:20.80 (24.8%) stddev-sans-first:21.45 10:25:02 INFO - 2015-11-18 10:25:02,242 DEBUG : BROWSER_OUTPUT: Values: 84.0 100.0 134.0 136.0 103.0 85.0 84.0 86.0 84.0 83.0 10:25:02 INFO - 2015-11-18 10:25:02,242 DEBUG : BROWSER_OUTPUT: 10:25:02 INFO - 2015-11-18 10:25:02,242 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:56.50 Median:56.50 stddev:3.24 (5.7%) stddev-sans-first:3.43 10:25:02 INFO - 2015-11-18 10:25:02,242 DEBUG : BROWSER_OUTPUT: Values: 57.0 57.0 55.0 55.0 57.0 55.0 56.0 65.0 53.0 55.0 10:25:02 INFO - 2015-11-18 10:25:02,242 DEBUG : BROWSER_OUTPUT: 10:25:02 INFO - 2015-11-18 10:25:02,243 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.50 stddev:1.25 (1.9%) stddev-sans-first:1.17 10:25:02 INFO - 2015-11-18 10:25:02,243 DEBUG : BROWSER_OUTPUT: Values: 63.0 64.0 63.0 64.0 64.0 66.0 66.0 65.0 66.0 66.0 10:25:02 INFO - 2015-11-18 10:25:02,243 DEBUG : BROWSER_OUTPUT: 10:25:02 INFO - 2015-11-18 10:25:02,243 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.60 Median:82.00 stddev:9.80 (12.0%) stddev-sans-first:10.10 10:25:02 INFO - 2015-11-18 10:25:02,244 DEBUG : BROWSER_OUTPUT: Values: 81.0 82.0 82.0 79.0 96.0 105.0 103.0 83.0 82.0 83.0 10:25:02 INFO - 2015-11-18 10:25:02,244 DEBUG : BROWSER_OUTPUT: 10:25:02 INFO - 2015-11-18 10:25:02,244 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.20 Median:123.50 stddev:4.10 (3.3%) stddev-sans-first:3.24 10:25:02 INFO - 2015-11-18 10:25:02,244 DEBUG : BROWSER_OUTPUT: Values: 132.0 130.0 120.0 123.0 126.0 119.0 122.0 124.0 123.0 123.0 10:25:02 INFO - 2015-11-18 10:25:02,244 DEBUG : BROWSER_OUTPUT: 10:25:02 INFO - 2015-11-18 10:25:02,244 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.70 Median:137.50 stddev:14.20 (10.3%) stddev-sans-first:14.71 10:25:02 INFO - 2015-11-18 10:25:02,244 DEBUG : BROWSER_OUTPUT: Values: 132.0 136.0 138.0 137.0 134.0 124.0 138.0 135.0 166.0 167.0 10:25:02 INFO - 2015-11-18 10:25:02,244 DEBUG : BROWSER_OUTPUT: 10:25:02 INFO - 2015-11-18 10:25:02,244 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.00 stddev:0.99 (1.5%) stddev-sans-first:1.05 10:25:02 INFO - 2015-11-18 10:25:02,244 DEBUG : BROWSER_OUTPUT: Values: 65.0 64.0 64.0 65.0 64.0 65.0 67.0 65.0 64.0 66.0 10:25:02 INFO - 2015-11-18 10:25:02,244 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:25:02 INFO - 2015-11-18 10:25:02,244 DEBUG : BROWSER_OUTPUT: 10:25:02 INFO - 2015-11-18 10:25:02,968 INFO : Browser exited with error code: 0 10:25:03 INFO - 2015-11-18 10:25:03,014 INFO : Completed test kraken (00:00:56) 10:25:03 INFO - 2015-11-18 10:25:03,015 INFO : Starting test v8_7 10:25:03 INFO - 2015-11-18 10:25:03,015 DEBUG : operating with platform_type : mac_ 10:25:03 INFO - 2015-11-18 10:25:03,015 INFO : Initialising browser for v8_7 test... 10:25:03 INFO - 2015-11-18 10:25:03,027 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/tmpPKRova/profile http://localhost:49269/getInfo.html 10:25:05 INFO - 2015-11-18 10:25:05,052 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:25:05 INFO - 2015-11-18 10:25:05,052 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:25:05 INFO - 2015-11-18 10:25:05,052 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 10:25:05 INFO - 2015-11-18 10:25:05,052 DEBUG : BROWSER_OUTPUT: __metrics 10:25:05 INFO - 2015-11-18 10:25:05,069 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:25:05 INFO - 2015-11-18 10:25:05,738 INFO : Browser initialized. 10:25:05 INFO - 2015-11-18 10:25:05,739 INFO : Running cycle 1/1 for v8_7 test... 10:25:05 INFO - 2015-11-18 10:25:05,739 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/tmpPKRova/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:25:17 INFO - 2015-11-18 10:25:17,541 DEBUG : BROWSER_OUTPUT: RSS: Main: 226029568 10:25:17 INFO - 2015-11-18 10:25:17,541 DEBUG : BROWSER_OUTPUT: 10:25:38 INFO - 2015-11-18 10:25:38,913 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/v8_7/run.html (next: http://localhost:49269/tests/v8_7/run.html) 10:25:39 INFO - 2015-11-18 10:25:39,169 DEBUG : BROWSER_OUTPUT: RSS: Main: 702324736 10:25:39 INFO - 2015-11-18 10:25:39,169 DEBUG : BROWSER_OUTPUT: 10:25:39 INFO - 2015-11-18 10:25:39,169 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:25:39 INFO - 2015-11-18 10:25:39,169 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:25:39 INFO - 2015-11-18 10:25:39,169 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:25:39 INFO - 2015-11-18 10:25:39,169 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:25:39 INFO - 2015-11-18 10:25:39,169 DEBUG : BROWSER_OUTPUT: |0;Richards;148.63258026159335 10:25:39 INFO - 2015-11-18 10:25:39,169 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;161.26431220770843 10:25:39 INFO - 2015-11-18 10:25:39,169 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.19052956010086 10:25:39 INFO - 2015-11-18 10:25:39,170 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4761.9047619047615 10:25:39 INFO - 2015-11-18 10:25:39,170 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1709.4017094017095 10:25:39 INFO - 2015-11-18 10:25:39,170 DEBUG : BROWSER_OUTPUT: |5;Earley;801.2820512820513 10:25:39 INFO - 2015-11-18 10:25:39,170 DEBUG : BROWSER_OUTPUT: |6;Boyer;12670.886075949367 10:25:39 INFO - 2015-11-18 10:25:39,170 DEBUG : BROWSER_OUTPUT: |7;RegExp;28416.666666666668 10:25:39 INFO - 2015-11-18 10:25:39,170 DEBUG : BROWSER_OUTPUT: |8;Splay;642.6735218508998 10:25:39 INFO - 2015-11-18 10:25:39,170 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4513.513513513513 10:25:39 INFO - 2015-11-18 10:25:39,170 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:25:39 INFO - 2015-11-18 10:25:39,170 DEBUG : BROWSER_OUTPUT: __startTimestamp1447871139162__endTimestamp 10:25:39 INFO - 2015-11-18 10:25:39,170 DEBUG : BROWSER_OUTPUT: 10:25:39 INFO - 2015-11-18 10:25:39,170 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:25:39 INFO - 2015-11-18 10:25:39,170 DEBUG : BROWSER_OUTPUT: Number of tests: 10 10:25:39 INFO - 2015-11-18 10:25:39,170 DEBUG : BROWSER_OUTPUT: 10:25:39 INFO - 2015-11-18 10:25:39,170 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:148.63 Median:148.63 stddev:0.00 (0.0%) 10:25:39 INFO - 2015-11-18 10:25:39,170 DEBUG : BROWSER_OUTPUT: Values: 148.6 10:25:39 INFO - 2015-11-18 10:25:39,171 DEBUG : BROWSER_OUTPUT: 10:25:39 INFO - 2015-11-18 10:25:39,171 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:161.26 Median:161.26 stddev:0.00 (0.0%) 10:25:39 INFO - 2015-11-18 10:25:39,171 DEBUG : BROWSER_OUTPUT: Values: 161.3 10:25:39 INFO - 2015-11-18 10:25:39,171 DEBUG : BROWSER_OUTPUT: 10:25:39 INFO - 2015-11-18 10:25:39,171 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.19 Median:280.19 stddev:0.00 (0.0%) 10:25:39 INFO - 2015-11-18 10:25:39,171 DEBUG : BROWSER_OUTPUT: Values: 280.2 10:25:39 INFO - 2015-11-18 10:25:39,171 DEBUG : BROWSER_OUTPUT: 10:25:39 INFO - 2015-11-18 10:25:39,171 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4761.90 Median:4761.90 stddev:0.00 (0.0%) 10:25:39 INFO - 2015-11-18 10:25:39,171 DEBUG : BROWSER_OUTPUT: Values: 4761.9 10:25:39 INFO - 2015-11-18 10:25:39,171 DEBUG : BROWSER_OUTPUT: 10:25:39 INFO - 2015-11-18 10:25:39,171 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1709.40 Median:1709.40 stddev:0.00 (0.0%) 10:25:39 INFO - 2015-11-18 10:25:39,171 DEBUG : BROWSER_OUTPUT: Values: 1709.4 10:25:39 INFO - 2015-11-18 10:25:39,171 DEBUG : BROWSER_OUTPUT: 10:25:39 INFO - 2015-11-18 10:25:39,172 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:801.28 Median:801.28 stddev:0.00 (0.0%) 10:25:39 INFO - 2015-11-18 10:25:39,172 DEBUG : BROWSER_OUTPUT: Values: 801.3 10:25:39 INFO - 2015-11-18 10:25:39,172 DEBUG : BROWSER_OUTPUT: 10:25:39 INFO - 2015-11-18 10:25:39,172 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12670.89 Median:12670.89 stddev:0.00 (0.0%) 10:25:39 INFO - 2015-11-18 10:25:39,172 DEBUG : BROWSER_OUTPUT: Values: 12670.9 10:25:39 INFO - 2015-11-18 10:25:39,172 DEBUG : BROWSER_OUTPUT: 10:25:39 INFO - 2015-11-18 10:25:39,172 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:28416.67 Median:28416.67 stddev:0.00 (0.0%) 10:25:39 INFO - 2015-11-18 10:25:39,172 DEBUG : BROWSER_OUTPUT: Values: 28416.7 10:25:39 INFO - 2015-11-18 10:25:39,172 DEBUG : BROWSER_OUTPUT: 10:25:39 INFO - 2015-11-18 10:25:39,172 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:642.67 Median:642.67 stddev:0.00 (0.0%) 10:25:39 INFO - 2015-11-18 10:25:39,172 DEBUG : BROWSER_OUTPUT: Values: 642.7 10:25:39 INFO - 2015-11-18 10:25:39,172 DEBUG : BROWSER_OUTPUT: 10:25:39 INFO - 2015-11-18 10:25:39,172 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4513.51 Median:4513.51 stddev:0.00 (0.0%) 10:25:39 INFO - 2015-11-18 10:25:39,173 DEBUG : BROWSER_OUTPUT: Values: 4513.5 10:25:39 INFO - 2015-11-18 10:25:39,173 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:25:39 INFO - 2015-11-18 10:25:39,173 DEBUG : BROWSER_OUTPUT: 10:25:39 INFO - 2015-11-18 10:25:39,969 INFO : Browser exited with error code: 0 10:25:39 INFO - 2015-11-18 10:25:39,986 INFO : Completed test v8_7 (00:00:36) 10:25:40 INFO - 2015-11-18 10:25:40,287 INFO : Completed test suite (00:20:07) 10:25:40 INFO - 2015-11-18 10:25:40,287 DEBUG : Working with test: dromaeo_css 10:25:40 INFO - 2015-11-18 10:25:40,288 DEBUG : Generating results file: dromaeo_css 10:25:40 INFO - 2015-11-18 10:25:40,289 DEBUG : Working with test: kraken 10:25:40 INFO - 2015-11-18 10:25:40,289 DEBUG : Generating results file: kraken 10:25:40 INFO - 2015-11-18 10:25:40,289 INFO : javascript benchmark 10:25:40 INFO - 2015-11-18 10:25:40,289 DEBUG : Working with test: v8_7 10:25:40 INFO - 2015-11-18 10:25:40,289 DEBUG : Generating results file: v8_7 10:25:40 INFO - 2015-11-18 10:25:40,290 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:25:40 INFO - 2015-11-18 10:25:40,809 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 10:25:40 INFO - 2015-11-18 10:25:40,809 DEBUG : process_Request line: dromaeo_css 7375.25 graph.html#tests=[[72,64,59]] 10:25:40 INFO - 2015-11-18 10:25:40,809 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:25:40 INFO - 2015-11-18 10:25:40,837 DEBUG : process_Request line: kraken 1412.10 graph.html#tests=[[232,64,59]] 10:25:40 INFO - 2015-11-18 10:25:40,837 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:25:40 INFO - 2015-11-18 10:25:40,867 DEBUG : process_Request line: v8_7 20581.01 graph.html#tests=[[230,64,59]] 10:25:40 INFO - 2015-11-18 10:25:40,868 INFO : javascript benchmark 10:25:40 INFO - 2015-11-18 10:25:40,869 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3413.5562376891003, 3497.842597083131, 3527.03006673165, 3531.699805516531, 3548.91127721807, 5718.9428105718935, 5739.684317362543, 5798.391168927265, 5800.5649576281785, 5801.4198580141965, 5795.043817770063, 5911.970440147793, 5921.585489015771, 5933.584649074566, 5957.493613042886, 5315.627906046579, 5351.892962140755, 5426.104692725696, 5433.673979561239, 5443.101888188444, 5445.918311225335, 5446.645968012086, 5450.945490545084, 5451.536619387337, 5458.699771512565, 5361.785528578852, 5434.130539113743, 5440.6735595864375, 5447.319085114361, 5447.536959358439, 5407.432219616942, 5428.240046393508, 5432.266644003088, 5436.673799572039, 5438.864028399282, 5273.947260527422, 5372.301600791911, 5390.0, 5409.648372855791, 5412.485813847678, 5804.216430781875, 5898.321693005273, 5933.0, 5962.25471816023, 5979.760809567612, 6376.489880809524, 6379.712912918883, 6385.361463853624, 6393.264774550893, 6405.263394709621, 5654.236678048452, 6219.2847822500535, 6223.813285601439, 6400.39196276353, 6403.647799371032, 5792.102224155263, 6055.697215139226, 6058.363871793486, 6073.242289305543, 6078.361772013964, 6378.904316435257, 6461.515386346043, 6463.838404039937, 6471.546991710629, 6481.578697384655, 6082.695865206722, 6145.539084568675, 6163.660998645118, 6176.227971503562, 6186.041163619556, 6253.499720022387, 6280.466160376419, 6340.175777148941, 6368.0, 6378.17083779115, 6304.18045654062, 6345.238571371465, 6360.809175724736, 6361.077643741724, 6364.872702546016, 6205.6586887720705, 6362.045693146065, 6373.776917807854, 6379.585326953826, 6393.424591786761, 4932.605391568666, 5022.321986531844, 5039.798408063636, 5068.695878247317, 5074.898502029939, 4543.091381723669, 4543.34121552373, 4558.658100642465, 4588.816447342136, 4600.907981840344, 5936.079907614327, 5952.821415357546, 5953.226080609493, 5968.343482216953, 5974.312954010257, 6209.782657606962, 6234.314225435199, 6331.0819931110655, 6350.936490635127, 6368.904466433008, 5896.174535565025, 5905.645661260252, 5917.6745279010065, 5924.259467566554, 5954.85112872173, 5516.282883225155, 5526.557875369961, 5537.58468114893, 5551.167324901297, 5554.2779438672715, 6265.467435267962, 6335.651539165206, 6366.108744775735, 6378.90431643535, 6463.062855885964, 6325.399087086719, 6360.936390636034, 6362.522810789302, 6370.108184854217, 6388.297287298301, 6480.092787009728, 6501.187351581052, 6514.381133792472, 6522.836929076811, 6522.836929076811, 6135.441059721752, 6206.317305096345, 6263.123162757127, 6267.780627678009, 6346.936530634634, 5452.836414907559, 6155.0151975683675, 6308.810735677937, 6353.110564521063, 6376.011718183689, 6238.220222472191, 6278.121063051268, 6288.528360373082, 6290.0, 6306.65313407767, 5982.012967860254, 6094.114023714709, 6107.067445037884, 6123.418275263843, 6257.499400047895, 6147.569670123048, 6148.50811935053, 6157.876842463036, 6163.3836616338, 6166.568340216142, 6257.2804127525915, 6268.435840774352, 6280.466160376236, 6283.2774230962195, 6295.716692748929, 5871.559633027455, 6002.879942401215, 6008.1588577598295, 6020.036794112921, 6098.162381879712], "unit": "ms", "name": "dojo.html", "value": 5843.554742612703}, {"lowerIsBetter": false, "replicates": [559.8068666310124, 570.0594019867222, 596.3261514488627, 607.9846656084338, 631.7220423013871, 28197.0, 32361.838190809012, 33257.833710831444, 42165.156696866085, 44819.0, 44806.551934480725, 45200.321995170016, 45233.09533809322, 45249.321260181045, 45361.0, 8731.257843083315, 9754.365966212192, 9931.90068099317, 9948.502574871227, 9958.452285124315, 8848.424852384607, 10226.33528820628, 12286.569970051005, 12289.692757681085, 12291.569795057174, 11845.17083804134, 11953.641390758292, 11961.820572691417, 11962.10284228682, 11968.34174120423, 7867.881981770278, 8935.553222338922, 9056.909430905673, 11952.94023529881, 12135.08986825987, 8863.11368863115, 8972.237359824423, 11661.067114630809, 12023.579174728842, 12058.457369418396, 40981.59018409807, 41220.0, 41380.79309603433, 41388.1722365554, 41400.0, 3300.47192449207, 3390.86436542538, 3432.2449061206494, 3842.865499707497, 3905.5703872573995, 30124.8493757532, 30276.394472110434, 30385.392292154254, 30553.93061242868, 30616.2345941351, 2451.32378439876, 2555.6166575013713, 2565.204786516167, 2655.803671228778, 2745.3822889849826, 504268.0, 505252.0, 505480.99999999633, 506792.0, 507829.0, 61579.38420615826, 62483.06275405872, 62928.11215663446, 69107.65446172738, 69751.0, 61415.07877381843, 61624.69187654033, 73750.0, 74973.625131874, 75081.6245918767, 16623.6675266494, 16640.084795336374, 16814.15929203535, 16814.663706725798, 16852.57868553296, 12800.231986080866, 12851.550195743104, 12855.614331570068, 12861.614151575468, 12886.80669789954, 17294.740578891327, 21188.15247390087, 21318.893405532872, 21410.89294553517, 21420.250291240045, 8936.597853096626, 9051.456912585134, 9057.954710226539, 9065.41074830134, 9184.90815091854, 824.6948629007305, 917.5824999625155, 1018.7758693087509, 1119.3004372267333, 1177.1877404590805, 28254.71745282562, 30191.698083019328, 30227.395452090834, 30957.535636965462, 30968.69031309703, 1089.9237053406343, 1094.1465656787718, 1098.0, 1173.85913690356, 1190.4880901212562, 14466.349014294383, 14520.491782787763, 14594.927025364805, 14919.850801491846, 14946.92526537382, 458273.0, 462774.744505108, 463422.0, 464537.0, 464799.0, 56949.43050569524, 57228.713856431285, 57233.42766572281, 57288.713556431954, 57433.71283143641, 1460.4158336665419, 1479.297333766474, 1480.1489143742606, 1493.843146469605, 1501.0543357684808, 23225.535489290458, 27135.914563417242, 28575.28561785972, 29379.118626441243, 30888.0, 53227.0, 53674.194887075944, 53690.46309536855, 53712.462875370744, 53741.0, 404890.0, 405941.97029014665, 405985.97007014777, 406122.0, 406846.0, 29984.550231746103, 30735.2316192097, 32954.67045329516, 34146.146346340545, 34957.65042349544, 43362.78318608513, 43819.34270985874, 43889.78055109704, 44016.55983440253, 44371.33442998293, 36538.26923461463, 36620.63379366172, 37358.75847449053, 37437.62562374341, 37738.0, 28955.573848187614, 30874.91937782167, 35784.642153578134, 37903.43144852774, 38925.6107438922, 36653.45019824758, 37378.06554836151, 38309.808450957564, 38382.61617383902, 38429.4235586472, 31454.84272578714, 33592.49611255882, 33818.41725185478, 33909.49135762916, 34115.14712132217, 24895.626565601167, 24972.50054998926, 25140.62289065629, 25387.0, 25416.618750719124], "unit": "ms", "name": "ext.html", "value": 20210.419486855233}, {"lowerIsBetter": false, "replicates": [351.3640311037023, 356.84120566347974, 358.1976372924646, 362.6228722128987, 364.9817509124543, 15867.365305387772, 16136.919315403407, 19430.028498575066, 20200.98995050247, 20850.748955062707, 16728.41450549228, 19248.23007079715, 20828.375148745523, 21278.468038299052, 21307.68038479424, 5707.400722924085, 5967.0, 5984.910226346608, 5993.0, 6013.037913933771, 4244.660427165819, 4381.3647021181905, 5952.9107063394085, 5997.970010149965, 6000.489958353545, 6021.488173505235, 6471.708773105222, 6473.902891456609, 6476.481881449473, 6487.318831522669, 6303.747850085991, 6433.9678301608665, 6437.452816510602, 6445.065465507499, 6450.290468048511, 5594.216809646653, 5597.552195824324, 5608.551315894719, 5616.213730077792, 5620.662760234399, 25608.48783024329, 25717.228483145536, 25883.223503294932, 26091.956321747108, 26194.0, 1857.3777784442093, 1949.87325823821, 1951.4828570428847, 1989.2838578111869, 2304.493011537459, 8438.831223375499, 10152.238582106298, 10221.437820919846, 10428.79142417155, 10714.624988125379, 1628.6742651469754, 1630.3071194742188, 1631.844974727399, 1683.781108455905, 1684.0, 92684.53657731735, 96130.0386996128, 97832.51083744607, 97939.51030244875, 98481.0, 5797.913031304533, 6901.102856628606, 6929.549579277432, 6986.9650651746415, 6997.790066298019, 7932.524048557105, 7937.0, 7948.960255198803, 7952.642131104114, 7989.56057416836, 5838.0, 5862.589618726648, 5878.382769809108, 5915.526757859361, 5919.792807251725, 6295.150154729145, 6304.968475157687, 6347.460465860361, 6357.650329231937, 6372.426481616677, 2669.0, 2719.2386131883104, 3035.9374219023166, 3083.5066389377594, 3105.503119500869, 1073.3774410841693, 1079.5897558927713, 1114.5764609448358, 1116.1071143085499, 1165.4289398194824, 410.86236110902587, 414.1241274703979, 434.75653633965084, 480.9278608208797, 504.04231959277666, 12363.505459781687, 12482.875171248172, 12969.092163548461, 12972.481100756053, 13002.414891329912, 390.63865924020166, 419.88033410478477, 475.7074399244509, 490.1911845455028, 508.8829569199105, 4779.808807647724, 6676.9666151668935, 6924.826879327957, 6985.930140698528, 7056.188538318159, 789712.0, 791468.0, 809853.0, 810211.0, 816368.0, 99098.50450747844, 123694.0, 123775.0, 125234.3738281321, 126385.36807316089, 533.9626226164208, 553.5129086403939, 555.2420945409567, 557.83543854563, 558.8826346467288, 9769.511524423608, 11782.587609433629, 11890.643280701594, 11982.880171198525, 11991.940040299743, 48991.75504122599, 49117.75441122772, 50000.0, 53489.19766203432, 53555.393338199916, 68745.65627171833, 69112.0, 69818.30181698118, 69937.30062699308, 70717.29282707107, 6397.712102955471, 6504.60972341661, 6573.0, 6579.440747536513, 6587.440067594308, 12269.93865030669, 12584.622461326175, 12658.11393202467, 12679.80980285315, 12681.873181268069, 9349.205317548085, 9755.463449510062, 10165.542550585093, 10759.139268858316, 10867.076298514714, 10735.570577176826, 10745.838812417664, 10877.67366978992, 10892.509837057192, 11172.441377931233, 10965.780684386427, 11212.495437705486, 11315.321080735182, 11420.0, 11421.543138274375, 5898.587098903035, 6438.323975982642, 6478.384553467413, 6503.479721622353, 6624.403803657694, 11005.284656497302, 11144.554217831195, 11328.0, 11338.319700817978, 11345.602903898323], "unit": "ms", "name": "jquery.html", "value": 7815.320142346315}, {"lowerIsBetter": false, "replicates": [1626.7397216445368, 1697.278656570957, 1909.8949557774317, 1946.1997652171738, 1993.521554826841, 7567.091948966125, 7955.244251796077, 8257.339412846974, 8451.788705282372, 8468.491890486575, 8212.671493140282, 8333.374996875229, 8372.874406883886, 8374.288185504225, 8379.790505237372, 2129.7763734807854, 2176.967345489811, 2351.0243249051664, 2369.0168580039262, 2372.229025566689, 2378.3102900158933, 2418.22616762636, 2419.237940048879, 2419.842710223839, 2426.0538390027905, 2325.6744055832196, 2375.0499800079933, 2380.5357955198742, 2393.5930891748444, 2401.5677178107935, 2131.968020479694, 2184.224600266898, 2188.0, 2312.7802858728396, 2316.652502124678, 2368.14746691191, 2375.10933399975, 2375.7149142102885, 2377.9286621401384, 2379.0, 8273.296769774577, 8357.331413486967, 8370.916290837136, 8386.496810191407, 8404.705835295796, 5101.489851014906, 5176.0683077046115, 5188.066148093341, 5219.6085293602755, 5254.97372513135, 3498.6326435724136, 3522.6125126236093, 3595.874144404959, 3602.603713591503, 3606.296772129436, 1058.2750815691277, 1059.4014381874217, 1082.577794660083, 1088.434014312553, 1090.907272881806, 11127.944360278228, 11147.386893720843, 11165.776684466346, 11167.0, 11194.608188713355, 4647.094199333051, 4683.110209060268, 4688.9296660549435, 4717.339572459859, 4754.548317909793, 9721.368111072758, 9723.416595004323, 9729.951350243346, 9750.463724495221, 9769.120779129913, 5146.125158723026, 5260.736963151827, 5262.842114736487, 5268.051750684914, 5268.4994925482015, 4747.905041899143, 4752.643551733634, 4756.405449318835, 4757.405324334458, 4791.137595232892, 3870.632289932452, 3891.6497515223764, 3897.629725176104, 3932.7050471214775, 3942.9605703942593, 1268.7652784234947, 1273.0770191611007, 1276.5468258768003, 1282.2050328796206, 1292.3086148910288, 1299.7205600795874, 1336.4520546575857, 1344.213635023522, 1349.912255703376, 1364.501956785786, 7772.805679858049, 7933.404994625311, 7952.284294413531, 7962.0, 7963.681452741941, 489.3516091179202, 497.35344052731307, 500.4520050544648, 500.58951659639473, 506.4606194402949, 5975.0, 6127.479164271087, 6127.571070025145, 6205.317415084337, 6411.455026322721, 9831.311808173503, 9958.452285124387, 10019.699409017741, 10144.949275253577, 10170.847437288447, 9916.553755081039, 9917.851232231378, 9932.652357167464, 10003.199744020461, 10032.69901902944, 7770.10643775973, 7808.726694565663, 7845.548573513918, 7852.882206766903, 7874.6850125994315, 7833.608319584112, 7857.724979625686, 7859.646315915683, 7859.724909628136, 7861.646225919733, 8718.302535796995, 8776.605052772768, 8958.656201569816, 9040.773980650274, 9075.364724469224, 9085.954570227106, 9371.0, 9464.290178236522, 9474.668386606436, 9479.905200947902, 7878.881816772639, 7968.322692571196, 7969.681212751425, 7978.481398709066, 7991.24083212094, 7787.987561616954, 7997.240262175084, 8044.2760151586635, 8046.919530804617, 8053.637586308513, 7483.064616922885, 7519.436042296959, 7582.507137036075, 7677.462577619736, 7680.846383072419, 7234.312740289664, 7307.7807665770115, 7312.488125831141, 7477.513961592479, 7520.323170914644, 7429.665665045194, 7517.511361761468, 7574.091109066947, 7577.355924746458, 7579.696812127453, 6853.4859885507785, 6907.033015377951, 6908.412784913137, 6916.412104971134, 6919.688614012281, 6400.871982560229, 6960.443164546926, 6974.79075627732, 6975.40709039717, 6991.265917078634], "unit": "ms", "name": "mootools.html", "value": 4727.818097132753}, {"lowerIsBetter": false, "replicates": [315.95102759072347, 322.2121911925342, 329.0687354785955, 332.8285932744637, 333.83642015412454, 6764.255931847493, 6868.484863635234, 6877.965610171948, 6884.3115688431135, 6905.205901321349, 5660.264165658458, 6726.798196054114, 6796.082528858615, 6816.7954961351115, 6823.829404264896, 5034.5468907798295, 5081.644284900059, 5084.339035925324, 5084.949150508484, 5086.364204474441, 4956.1822299320565, 5062.519060689228, 5093.745312734367, 5102.846914592549, 5110.259012443194, 5056.367954005749, 5063.240513922904, 5082.390113186423, 5083.085044691954, 5113.181890897457, 5039.193729003378, 5049.67177133487, 5054.267131265946, 5062.670926389773, 5075.213341931988, 4144.088300573869, 4229.323308270693, 4243.448351714288, 4318.201132790444, 4341.131773645284, 6413.871722565569, 6521.576097553644, 6569.244536878225, 6600.702968366435, 6632.137822083147, 5956.195913551658, 5973.492253158487, 5974.641521508724, 5979.22270104888, 5980.760769569212, 5737.88524229513, 7254.492185547014, 7305.639405873305, 7330.413566914634, 7332.0, 4804.807807687688, 4808.543188397097, 4812.061647978646, 4819.783109760069, 4825.4933232010835, 7678.692852285902, 7708.807279817994, 7723.729669461598, 7726.0, 7748.18644042373, 4720.905581888343, 4852.2479015752615, 4895.437024742129, 4896.2655601660035, 4903.926441103386, 4994.1759609663995, 4995.325631039836, 5005.924911126336, 5009.824656137091, 5011.874703132378, 4863.489333619989, 5914.172015917775, 5929.140274660236, 5941.940580594225, 5959.076343166729, 7300.196978332379, 7312.488125831247, 7328.706851725978, 7336.376408005272, 7436.851262974818, 1665.267282395742, 1740.617064245864, 1751.0019289005145, 1756.5257380507192, 1761.5860272835873, 1127.7293449572044, 1134.5858761551974, 1135.432283858071, 1138.0269869261663, 1149.6204554534593, 6902.137232845895, 6912.239653638096, 6928.515003949776, 6928.965355173192, 6953.096097507393, 7626.923730762733, 7639.847203055908, 7655.272749088827, 7656.655450504741, 7685.154632990367, 6685.364890335411, 6878.65606719662, 6889.242183359826, 6919.100516932867, 6931.306869313129, 3947.9802600987387, 4040.0303927057294, 4045.2516284487465, 4071.816768245436, 4075.7962101894786, 7877.645505952131, 7888.40836937232, 7944.165862584461, 8008.239217274349, 8016.278534931884, 7925.247101525461, 7949.364050875916, 7981.640826162837, 7981.72063977758, 7999.800004999922, 7724.8455030900195, 7977.880331795028, 7985.361171106298, 8001.799955001172, 8006.879896801553, 7658.655360508902, 7679.385649147943, 7685.538867667958, 7685.769426917202, 7705.653245604073, 7386.372158366599, 7548.962255188689, 7549.0941087069905, 7555.8866616999685, 7583.27958843909, 8043.115257321573, 8050.83898322042, 8053.872457855788, 8056.919430805617, 8069.919300807152, 4776.617870570277, 4813.879653008703, 4814.614830813456, 4826.251930950708, 4836.733979631154, 6249.96875015622, 7467.402607791472, 7700.0, 7734.7679569613, 7757.146713861358, 7413.592252425952, 7417.443691723034, 7418.888716669362, 7424.554526728413, 7424.591647459441, 7193.928060719326, 7363.852722945404, 7380.704771809067, 7388.113426388652, 7399.112106547249, 7214.927850721426, 7237.565746055254, 7247.927520724726, 7250.709971601077, 7253.528520646141, 6030.396960303934, 7396.889046664197, 7402.814929626802, 7418.072740907387, 7419.0, 7042.22535521082, 7256.1655409628565, 7277.126744790659, 7284.235155308616, 7303.780886573411], "unit": "ms", "name": "prototype.html", "value": 5385.372005684143}, {"lowerIsBetter": false, "replicates": [725.256611972728, 767.735131379674, 799.7081065411127, 816.6121092481076, 841.3017195727539, 14998.77501837472, 15355.539333819976, 15358.232088395564, 15366.769498457505, 15386.846131538681, 14145.575632731008, 14358.569242922704, 14365.138091714478, 14372.784408233885, 14373.281335933214, 738.4314078159814, 747.5365273530391, 752.4093586534572, 904.5070436612045, 924.0251534630962, 916.9954150229239, 917.9449233046005, 930.0931591698107, 930.9348345615809, 930.972070837876, 765.9272369124924, 991.9156871665917, 994.7264502261863, 995.8854731705837, 999.0708640963901, 772.75658167677, 785.3010820369875, 962.3888830592554, 981.9263555233315, 983.5868935047297, 736.1571001203592, 738.3686947659727, 738.4572339330588, 739.1868944161433, 739.9408047356198, 14962.850371496363, 15176.696466070616, 15197.392104315813, 15212.315445804965, 15304.311305991258, 10289.279750417474, 12254.0, 12461.813072803916, 12607.873921260762, 12701.872981270162, 9857.507124643811, 10233.948830255875, 10244.74388140295, 10250.589976400935, 10266.178705703525, 3477.9826100869586, 3530.082178633548, 3531.858725650971, 3537.6992955598803, 3544.7341449391397, 77685.61157194234, 78203.0, 80056.19943800545, 80576.59711701462, 80870.0, 9485.75399583041, 9571.28215383849, 9728.17310528613, 9815.647214906596, 9876.358036727734, 21709.67435488469, 21730.78269217319, 21744.0, 21745.912704365033, 21807.0, 7456.7762967111075, 7496.587687677121, 7547.924520754722, 7599.848003040019, 7687.654055567513, 3991.5409727881083, 4043.73715708478, 4065.6950728695465, 4065.837366505307, 4080.5103387593085, 3541.29174165168, 3578.6421357864006, 3583.4087375582735, 3585.1933315003917, 3588.2823435313044, 535.9732013399314, 547.698765678883, 563.0540691638006, 564.0552075273899, 565.541911052041, 437.83362322317953, 485.7619766314551, 553.8839238933552, 624.9812505624839, 646.360103497534, 8464.32285417165, 9239.676611318571, 9286.67496637628, 9345.392549484262, 9587.0, 479.72895314147394, 531.0759278854842, 592.4667798980865, 624.4192900602484, 663.0419044480775, 3708.851645934132, 3747.887563373103, 3811.213591511233, 4005.2790497710694, 4172.812223449952, 81547.0, 102124.48937755264, 102767.0, 102852.0, 103837.48081259546, 84789.0, 85421.0, 86495.1350486487, 86887.0, 88183.0, 59776.402235977956, 76754.61622691852, 76917.61541192258, 77014.0, 77280.0, 8275.917240827515, 8335.333173345996, 8419.579021049045, 8533.957330213309, 8553.0, 53463.0, 53482.73258633682, 53872.0, 53974.460255396945, 55384.169237460665, 70764.64617676879, 71132.0, 71216.28783712097, 77274.84087738577, 77468.45063098594, 7604.733834315773, 7628.771136865903, 7642.694292228471, 7677.654505547375, 7716.498427602188, 9725.0761177688, 11055.889441105486, 11289.37908415045, 11330.150238731963, 11468.4265786712, 10761.838572421577, 10924.344539327349, 11090.5563777448, 11096.0, 11349.375784331942, 9580.568874400808, 10319.122874555747, 10797.892021079688, 10826.621068262573, 10886.346819190874, 10558.524866380878, 10593.311434756715, 10652.360858348524, 10705.143588513056, 10889.727756806144, 9058.36591438593, 9187.219086377732, 9197.540122993958, 9431.95284023603, 9633.951830241085, 9307.348485606213, 9322.114399132071, 9421.29340299494, 9576.324976197966, 9614.567344469377], "unit": "ms", "name": "yui.html", "value": 6847.77526827285}], "name": "dromaeo_css", "value": 7375.24628686332}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 110.0, 105.0, 109.0, 110.0, 111.0, 99.0, 110.0, 100.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 107.3}, {"lowerIsBetter": true, "replicates": [144.0, 118.0, 139.0, 152.0, 118.0, 140.0, 118.0, 153.0, 157.0, 148.0], "unit": "ms", "name": "audio-beat-detection", "value": 138.7}, {"lowerIsBetter": true, "replicates": [180.0, 182.0, 184.0, 185.0, 251.0, 244.0, 187.0, 186.0, 182.0, 183.0], "unit": "ms", "name": "audio-dft", "value": 196.4}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 74.0, 73.0, 54.0, 58.0, 56.0, 71.0, 74.0, 54.0], "unit": "ms", "name": "audio-fft", "value": 64.4}, {"lowerIsBetter": true, "replicates": [85.0, 84.0, 119.0, 73.0, 75.0, 76.0, 108.0, 74.0, 75.0, 110.0], "unit": "ms", "name": "audio-oscillator", "value": 87.9}, {"lowerIsBetter": true, "replicates": [86.0, 87.0, 86.0, 87.0, 86.0, 86.0, 87.0, 86.0, 86.0, 87.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 86.4}, {"lowerIsBetter": true, "replicates": [94.0, 96.0, 94.0, 95.0, 93.0, 95.0, 95.0, 93.0, 94.0, 96.0], "unit": "ms", "name": "imaging-darkroom", "value": 94.5}, {"lowerIsBetter": true, "replicates": [84.0, 100.0, 134.0, 136.0, 103.0, 85.0, 84.0, 86.0, 84.0, 83.0], "unit": "ms", "name": "imaging-desaturate", "value": 97.9}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 55.0, 55.0, 57.0, 55.0, 56.0, 65.0, 53.0, 55.0], "unit": "ms", "name": "json-parse-financial", "value": 56.5}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 63.0, 64.0, 64.0, 66.0, 66.0, 65.0, 66.0, 66.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 64.7}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 82.0, 79.0, 96.0, 105.0, 103.0, 83.0, 82.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 87.6}, {"lowerIsBetter": true, "replicates": [132.0, 130.0, 120.0, 123.0, 126.0, 119.0, 122.0, 124.0, 123.0, 123.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.2}, {"lowerIsBetter": true, "replicates": [132.0, 136.0, 138.0, 137.0, 134.0, 124.0, 138.0, 135.0, 166.0, 167.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 140.7}, {"lowerIsBetter": true, "replicates": [65.0, 64.0, 64.0, 65.0, 64.0, 65.0, 67.0, 65.0, 64.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 64.9}], "name": "kraken", "value": 1412.1000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [148.63258026159335], "unit": "score", "name": "Richards", "value": 237.511856}, {"lowerIsBetter": false, "replicates": [161.26431220770843], "unit": "score", "name": "DeltaBlue", "value": 409.99771799999996}, {"lowerIsBetter": false, "replicates": [280.19052956010086], "unit": "score", "name": "Encrypt", "value": 949.9999890000003}, {"lowerIsBetter": false, "replicates": [4761.9047619047615], "unit": "score", "name": "Decrypt", "value": 55.89801000000001}, {"lowerIsBetter": false, "replicates": [1709.4017094017095], "unit": "score", "name": "RayTrace", "value": 432.89356499999985}, {"lowerIsBetter": false, "replicates": [801.2820512820513], "unit": "score", "name": "Earley", "value": 831.745824}, {"lowerIsBetter": false, "replicates": [12670.886075949367], "unit": "score", "name": "Boyer", "value": 52.597979020979054}, {"lowerIsBetter": false, "replicates": [28416.666666666668], "unit": "score", "name": "RegExp", "value": 32.05812316715544}, {"lowerIsBetter": false, "replicates": [642.6735218508998], "unit": "score", "name": "Splay", "value": 126.799996}, {"lowerIsBetter": false, "replicates": [4513.513513513513], "unit": "score", "name": "NavierStokes", "value": 328.7904191616765}], "name": "v8_7", "value": 20581.013242706904}]} 10:25:40 INFO - RETURN: dromaeo_css: 7375.25 10:25:40 INFO - RETURN: kraken: 1412.10 10:25:40 INFO - RETURN: v8_7: 20581.01 10:25:40 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,59]]", "result": "20581.01"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1412.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7375.25"}}} 10:25:40 INFO - Return code: 0 10:25:40 INFO - # TBPL SUCCESS # 10:25:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:25:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:25:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:25:40 INFO - 2015-11-18 10:25:40.945 screenresolution[1685:16554] starting screenresolution argv=screenresolution get 10:25:40 INFO - 2015-11-18 10:25:40.948 screenresolution[1685:16554] Display 0: 1600x1200x32@60 10:25:40 INFO - 2015-11-18 10:25:40.953 screenresolution[1686:16558] starting screenresolution argv=screenresolution list 10:25:40 INFO - Available Modes on Display 0 10:25:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:25:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:25:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:25:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:25:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:25:41 INFO - Intel Iris: 10:25:41 INFO - Chipset Model: Intel Iris 10:25:41 INFO - Type: GPU 10:25:41 INFO - Bus: Built-In 10:25:41 INFO - VRAM (Dynamic, Max): 1536 MB 10:25:41 INFO - Vendor: Intel (0x8086) 10:25:41 INFO - Device ID: 0x0a2e 10:25:41 INFO - Revision ID: 0x0009 10:25:41 INFO - Displays: 10:25:41 INFO - Display: 10:25:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:25:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:25:41 INFO - Display Serial Number: 1600x1200 60 10:25:41 INFO - Main Display: Yes 10:25:41 INFO - Mirror: Off 10:25:41 INFO - Online: Yes 10:25:41 INFO - Rotation: Supported 10:25:41 INFO - Return code: 0 10:25:41 INFO - Running post-action listener: _resource_record_post_action 10:25:41 INFO - Running post-run listener: _resource_record_post_run 10:25:42 INFO - Total resource usage - Wall time: 1239s; CPU: 53.0%; Read bytes: 33558016; Write bytes: 689937920; Read time: 447; Write time: 2048 10:25:42 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 335954432; Write bytes: 338081792; Read time: 26062; Write time: 646 10:25:42 INFO - run-tests - Wall time: 1209s; CPU: 53.0%; Read bytes: 32636416; Write bytes: 341489152; Read time: 434; Write time: 1369 10:25:42 INFO - Running post-run listener: _upload_blobber_files 10:25:42 INFO - Blob upload gear active. 10:25:42 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 10:25:42 INFO - Copying logs to upload dir... 10:25:42 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1293.512347 ========= master_lag: 0.15 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 33 secs) (at 2015-11-18 10:25:42.416958) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 10:25:42.420845) ========= 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.YOB6E0GDyM/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.y7jawezWp7/Listeners TMPDIR=/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/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/H0ZS5RUcQU6LaCIHt42nUA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009367 build_url: 'https://queue.taskcluster.net/v1/task/H0ZS5RUcQU6LaCIHt42nUA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 10:25:42.444600) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 10:25:42.444951) ========= 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.YOB6E0GDyM/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.y7jawezWp7/Listeners TMPDIR=/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/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.005069 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 10:25:42.494382) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 10:25:42.494691) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 10:25:42.495137) ========= ========= Total master_lag: 0.39 =========