Created
December 7, 2020 09:48
-
-
Save joeczucha/52d7a2bd99a242a4322e9042c5a70045 to your computer and use it in GitHub Desktop.
This file contains bidirectional Unicode text that may be interpreted or compiled differently than what appears below. To review, open the file in an editor that reveals hidden Unicode characters.
Learn more about bidirectional Unicode characters
12/07 09:18:53 Trace: [client/sonos] av_status | |
12/07 09:18:53 Trace: [Dining room] [zoneplayer/sonos] state from device: PLAYING | |
12/07 09:18:53 Trace: [Dining room] [zoneplayer/sonos] zoneplayer state: Playing | |
12/07 09:18:53 Trace: [client/sonos] av_status | |
12/07 09:18:53 Trace: [Dining room] [zoneplayer/sonos] state from device: PLAYING | |
12/07 09:18:53 Trace: [Dining room] [zoneplayer/sonos] zoneplayer state: Playing | |
12/07 09:18:53 Warn: [Dining room] [zoneplayer/sonos] position timer reported previous url, fix for bug 16980 triggered | |
12/07 09:18:53 Trace: [Dining room] [zoneplayer/sonos] Switching to next stream path | |
12/07 09:18:54 Info: [stats] 4977mb Virtual, 2581mb Physical, 1485mb Managed, 0 Handles, 95 Threads | |
12/07 09:18:59 Trace: [Dining room] [LowQuality, 24/44 AAC => 16/44] [100% buf] [PLAYING @ 11:39] RTE Radio 1 | |
12/07 09:19:01 Info: SKIP ID3 73 bytes | |
12/07 09:19:01 Trace: [roonapi] [apiclient 10.10.10.111:45236] CONTINUE Changed {"zones_seek_changed":[{"zone_id":"160108540d2a69d8ea46b513e5c73f9aa156","queue_time_remaining":-342,"seek_position":702}]} | |
12/07 09:19:01 Trace: [roonapi] [apiclient 10.10.10.111:45236] CONTINUE Changed {"zones_seek_changed":[{"zone_id":"160108540d2a69d8ea46b513e5c73f9aa156","queue_time_remaining":-346,"seek_position":706}]} | |
12/07 09:19:02 Trace: [roonapi] [apiclient 10.10.10.111:45236] CONTINUE Changed {"zones_seek_changed":[{"zone_id":"160108540d2a69d8ea46b513e5c73f9aa156","queue_time_remaining":-349,"seek_position":709}]} | |
12/07 09:19:04 Trace: [Dining room] [LowQuality, 24/44 AAC => 16/44] [100% buf] [PLAYING @ 11:49] RTE Radio 1 | |
12/07 09:19:09 Info: [stats] 4977mb Virtual, 2582mb Physical, 1499mb Managed, 0 Handles, 95 Threads | |
12/07 09:19:10 Info: SKIP ID3 73 bytes | |
12/07 09:19:10 Trace: [Dining room] [LowQuality, 24/44 AAC => 16/44] [100% buf] [PLAYING @ 11:49] RTE Radio 1 | |
12/07 09:19:10 Trace: [roonapi] [apiclient 10.10.10.111:45236] CONTINUE Changed {"zones_seek_changed":[{"zone_id":"160108540d2a69d8ea46b513e5c73f9aa156","queue_time_remaining":-350,"seek_position":710}]} | |
12/07 09:19:10 Trace: [roonapi] [apiclient 10.10.10.111:45236] CONTINUE Changed {"zones_seek_changed":[{"zone_id":"160108540d2a69d8ea46b513e5c73f9aa156","queue_time_remaining":-358,"seek_position":718}]} | |
12/07 09:19:11 Trace: [roonapi] [apiclient 10.10.10.111:45236] CONTINUE Changed {"zones_seek_changed":[{"zone_id":"160108540d2a69d8ea46b513e5c73f9aa156","queue_time_remaining":-359,"seek_position":719}]} | |
12/07 09:19:17 Trace: [Dining room] [LowQuality, 24/44 AAC => 16/44] [100% buf] [PLAYING @ 11:59] RTE Radio 1 | |
12/07 09:19:22 Info: SKIP ID3 73 bytes | |
12/07 09:19:22 Trace: [Dining room] [zoneplayer/sonos] transaction canceled, isplaying: True, did stream end: False, tx path: /15541faf600a4931bdd3c826795aa6cb/Roon73.flac, stream path: /15541faf600a4931bdd3c826795aa6cb/Roon73.flac, method: Get | |
12/07 09:19:22 Trace: [Dining room] [zoneplayer/sonos] transaction canceled, queue new stream | |
12/07 09:19:22 Trace: [client/sonos] next uri request | |
12/07 09:19:22 Trace: [client/sonos] next uri response | |
12/07 09:19:22 Trace: [Dining room] [zoneplayer/sonos] request matches stream, current path: /15541faf600a4931bdd3c826795aa6cb/Roon73.flac, next path: /86d42863eb4f466faf5bfc79bcebb2e6/Roon74.flac | |
12/07 09:19:22 Trace: [Dining room] [zoneplayer/sonos] request matches stream, current path: /15541faf600a4931bdd3c826795aa6cb/Roon73.flac, next path: /86d42863eb4f466faf5bfc79bcebb2e6/Roon74.flac | |
12/07 09:19:22 Trace: [roonapi] [apiclient 10.10.10.111:45236] CONTINUE Changed {"zones_seek_changed":[{"zone_id":"160108540d2a69d8ea46b513e5c73f9aa156","queue_time_remaining":-362,"seek_position":722}]} | |
12/07 09:19:22 Trace: [Dining room] [zoneplayer/sonos] transaction canceled, isplaying: True, did stream end: False, tx path: /86d42863eb4f466faf5bfc79bcebb2e6/Roon74.flac, stream path: /15541faf600a4931bdd3c826795aa6cb/Roon73.flac, method: Get | |
12/07 09:19:22 Trace: [client/sonos] av_status | |
12/07 09:19:22 Trace: [Dining room] [zoneplayer/sonos] state from device: PLAYING | |
12/07 09:19:22 Trace: [Dining room] [zoneplayer/sonos] zoneplayer state: Playing | |
12/07 09:19:22 Trace: [client/sonos] av_status | |
12/07 09:19:22 Trace: [Dining room] [zoneplayer/sonos] state from device: PLAYING | |
12/07 09:19:22 Trace: [Dining room] [zoneplayer/sonos] zoneplayer state: Playing | |
12/07 09:19:22 Warn: [Dining room] [zoneplayer/sonos] position timer reported previous url, fix for bug 16980 triggered | |
12/07 09:19:22 Trace: [Dining room] [zoneplayer/sonos] Switching to next stream path | |
12/07 09:19:22 Trace: [Dining room] [LowQuality, 24/44 AAC => 16/44] [100% buf] [PLAYING @ 12:03] RTE Radio 1 | |
12/07 09:19:23 Trace: [roonapi] [apiclient 10.10.10.111:45236] CONTINUE Changed {"zones_seek_changed":[{"zone_id":"160108540d2a69d8ea46b513e5c73f9aa156","queue_time_remaining":-366,"seek_position":726}]} | |
12/07 09:19:23 Trace: [roonapi] [apiclient 10.10.10.111:45236] CONTINUE Changed {"zones_seek_changed":[{"zone_id":"160108540d2a69d8ea46b513e5c73f9aa156","queue_time_remaining":-369,"seek_position":729}]} | |
12/07 09:19:24 Info: [stats] 4977mb Virtual, 2582mb Physical, 1526mb Managed, 0 Handles, 95 Threads | |
12/07 09:19:31 Info: SKIP ID3 73 bytes | |
12/07 09:19:31 Trace: [Dining room] [LowQuality, 24/44 AAC => 16/44] [100% buf] [PLAYING @ 12:09] RTE Radio 1 | |
12/07 09:19:31 Trace: [roonapi] [apiclient 10.10.10.111:45236] CONTINUE Changed {"zones_seek_changed":[{"zone_id":"160108540d2a69d8ea46b513e5c73f9aa156","queue_time_remaining":-370,"seek_position":730}]} | |
12/07 09:19:32 Trace: [roonapi] [apiclient 10.10.10.111:45236] CONTINUE Changed {"zones_seek_changed":[{"zone_id":"160108540d2a69d8ea46b513e5c73f9aa156","queue_time_remaining":-375,"seek_position":735}]} | |
12/07 09:19:32 Trace: [roonapi] [apiclient 10.10.10.111:45236] CONTINUE Changed {"zones_seek_changed":[{"zone_id":"160108540d2a69d8ea46b513e5c73f9aa156","queue_time_remaining":-379,"seek_position":739}]} | |
12/07 09:19:39 Info: [stats] 4977mb Virtual, 2582mb Physical, 1535mb Managed, 0 Handles, 95 Threads | |
12/07 09:19:40 Info: SKIP ID3 73 bytes | |
12/07 09:19:40 Trace: [Dining room] [LowQuality, 24/44 AAC => 16/44] [100% buf] [PLAYING @ 12:19] RTE Radio 1 | |
12/07 09:19:40 Trace: [roonapi] [apiclient 10.10.10.111:45236] CONTINUE Changed {"zones_seek_changed":[{"zone_id":"160108540d2a69d8ea46b513e5c73f9aa156","queue_time_remaining":-380,"seek_position":740}]} | |
12/07 09:19:41 Trace: [roonapi] [apiclient 10.10.10.111:45236] CONTINUE Changed {"zones_seek_changed":[{"zone_id":"160108540d2a69d8ea46b513e5c73f9aa156","queue_time_remaining":-381,"seek_position":741}]} | |
12/07 09:19:41 Trace: [roonapi] [apiclient 10.10.10.111:45236] CONTINUE Changed {"zones_seek_changed":[{"zone_id":"160108540d2a69d8ea46b513e5c73f9aa156","queue_time_remaining":-389,"seek_position":749}]} | |
12/07 09:19:49 Info: SKIP ID3 73 bytes | |
12/07 09:19:49 Trace: [Dining room] [LowQuality, 24/44 AAC => 16/44] [100% buf] [PLAYING @ 12:29] RTE Radio 1 | |
12/07 09:19:49 Trace: [roonapi] [apiclient 10.10.10.111:45236] CONTINUE Changed {"zones_seek_changed":[{"zone_id":"160108540d2a69d8ea46b513e5c73f9aa156","queue_time_remaining":-390,"seek_position":750}]} | |
12/07 09:19:50 Trace: [roonapi] [apiclient 10.10.10.111:45236] CONTINUE Changed {"zones_seek_changed":[{"zone_id":"160108540d2a69d8ea46b513e5c73f9aa156","queue_time_remaining":-399,"seek_position":759}]} | |
12/07 09:19:54 Info: [stats] 4977mb Virtual, 2582mb Physical, 1562mb Managed, 0 Handles, 95 Threads | |
12/07 09:20:00 Trace: [client/sonos] av_status | |
12/07 09:20:00 Trace: [Dining room] [zoneplayer/sonos] state from device: STOPPED | |
12/07 09:20:00 Trace: [Dining room] [zoneplayer/sonos] zoneplayer state: Playing | |
12/07 09:20:00 Trace: [Dining room] [zoneplayer/sonos] device stopped or paused by user, ending stream | |
12/07 09:20:00 Trace: [Dining room] [zoneplayer/sonos] State transition Playing => Disconnected | |
12/07 09:20:00 Trace: [endpoint/sonos/uuid:RINCON_347E5CF125BA01400] check zone coordinator, device coordinator: RINCON_347E5CF125BA01400, roon coordinator: RINCON_347E5CF125BA01400 | |
12/07 09:20:00 Trace: [client/sonos] timers stopped | |
12/07 09:20:00 Warn: [zone Dining room] Track Stopped Due to LostEndpoint | |
12/07 09:20:00 Trace: Attempting to play channel URL: hls://https%3a%2f%2fwww.rte.ie%2fmanifests%2fradio1.m3u8 | |
12/07 09:20:00 Info: [Dining room] [zoneplayer] Playing: channel://hls%3a%2f%2fhttps%253a%252f%252fwww.rte.ie%252fmanifests%252fradio1.m3u8 | |
12/07 09:20:00 Trace: [Dining room] [LowQuality, 24/44 AAC => 16/44] [100% buf] [PLAYING @ 12:39] RTE Radio 1 | |
12/07 09:20:00 Trace: [Dining room] [zoneplayer/sonos] endstream, zp state: Disconnected | |
12/07 09:20:00 Info: [Dining room] [zoneplayer] advance didn't change the track. returning short read | |
12/07 09:20:00 Info: [audio/env] [zoneplayer -> stream] All streams were disposed | |
12/07 09:20:00 Info: [zone Dining room] OnPlayFeedback StoppedLostEndpoint | |
12/07 09:20:00 Trace: [zone Dining room] Suspend | |
12/07 09:20:00 Trace: [Dining room] [zoneplayer/sonos] reached end of stream, closing connection | |
12/07 09:20:00 Trace: [Dining room] [zoneplayer/sonos] transaction canceled, isplaying: False, did stream end: True, tx path: /86d42863eb4f466faf5bfc79bcebb2e6/Roon74.flac, stream path: /86d42863eb4f466faf5bfc79bcebb2e6/Roon74.flac, method: Get | |
12/07 09:20:00 Info: [zone Dining room] OnPlayFeedback Stopped | |
12/07 09:20:00 Info: [zone Dining room] Canceling Pending Sleep | |
12/07 09:20:00 Trace: [Dining room] [zoneplayer/sonos] endstream, zp state: Disconnected | |
12/07 09:20:00 Info: [zone Dining room] Canceling Pending Sleep | |
12/07 09:20:00 Trace: [Dining room] [zoneplayer/sonos] endstream, zp state: Disconnected | |
12/07 09:20:00 Trace: [Dining room] [zoneplayer/sonos] endstream, zp state: Disconnected | |
12/07 09:20:00 Trace: [Dining room] [LowQuality, 24/44 AAC => 16/44] [100% buf] [STOPPED @ 0:00] RTE Radio 1 | |
12/07 09:20:00 Trace: [roonapi] [apiclient 10.10.10.111:45236] CONTINUE Changed {"zones_changed":[{"zone_id":"160108540d2a69d8ea46b513e5c73f9aa156","display_name":"Dining room","outputs":[{"output_id":"170108540d2a69d8ea46b513e5c73f9aa156","zone_id":"160108540d2a69d8ea46b513e5c73f9aa156","can_group_with_output_ids":["170108540d2a69d8ea46b513e5c73f9aa156","1701cee07a64e1de0d7bd9a941d18df41827","170157fce0867df0bf4787a0b427313fe98c","170153b9bd9f118053a5cca8ca03b219e935"],"display_name":"Dining room","volume":{"type":"number","min":0,"max":100,"value":22,"step":1,"is_muted":false,"hard_limit_min":0,"hard_limit_max":100,"soft_limit":100},"source_controls":[{"control_key":"1","display_name":"SYMFONISK (Dining Room)","supports_standby":false,"status":"indeterminate"}]}],"state":"stopped","is_next_allowed":false,"is_previous_allowed":false,"is_pause_allowed":false,"is_play_allowed":true,"is_seek_allowed":false,"queue_items_remaining":1,"queue_time_remaining":360,"settings":{"loop":"disabled","shuffle":false,"auto_radio":true},"now_playing":{"seek_position":null,"one_line":{"line1":"RTE Radio 1"},"two_line":{"line1":"RTE Radio 1","line2":""},"three_line":{"line1":"RTE Radio 1","line2":"","line3":""},"image_key":"afd611ddf80b5dce68aa13b8e9e99aff8bf23d351d0918d67f032e52c91c6dc24882ed6107bcb78f714d78cf03afae00f38e3b8e823c3c6dd3cb71f675a91481f1c07c9518261b3af42728d0343bff634d98380aad3997c33d35cb0a3bc32763139f6c5db22951dc9ff0e30e822296fd"}}],"zones_seek_changed":[{"zone_id":"160108540d2a69d8ea46b513e5c73f9aa156","queue_time_remaining":360,"seek_position":null}]} | |
12/07 09:20:00 Debug: [easyhttp] [2218] POST to https://internetradio.roonlabs.net/2/api/reporting/internetradioplayback/events?format=msgpack returned after 228 ms, status code: 200 | |
12/07 09:20:01 Info: SKIP ID3 73 bytes | |
12/07 09:20:01 Debug: [easyhttp] [2220] POST to https://internetradio.roonlabs.net/2/api/reporting/internetradioplayback/plays?format=msgpack returned after 179 ms, status code: 200 | |
12/07 09:20:01 Debug: [easyhttp] [2219] POST to https://internetradio.roonlabs.net/2/api/reporting/internetradioplayback/events?format=msgpack returned after 483 ms, status code: 200 | |
12/07 09:20:01 Debug: [easyhttp] [2221] POST to https://internetradio.roonlabs.net/2/api/reporting/internetradioplayback/plays?format=msgpack returned after 215 ms, status code: 400 | |
12/07 09:20:01 Info: [Dining room] [zoneplayer] Open Result (Playing):Result[Status=Success] | |
12/07 09:20:01 Info: [Dining room] [zoneplayer] Aborting play because track changed | |
12/07 09:20:01 Warn: [streammediafile] error reading stream: Cannot access a closed Stream. | |
12/07 09:20:01 Error: BufferedAudioSignal thread refuses to die | |
12/07 09:20:01 Info: [audio/env] [zoneplayer] All streams were disposed | |
12/07 09:20:01 Warn: [streammediafile] error reading stream: Cannot access a closed Stream. | |
12/07 09:20:09 Info: [stats] 4995mb Virtual, 2588mb Physical, 1576mb Managed, 0 Handles, 93 Threads | |
12/07 09:20:21 Trace: [broker/accounts] [heartbeat] now=12/07/2020 09:20:21 nextauthrefresh=12/07/2020 10:02:03 nextmachineallocate=12/07/2020 09:50:21 | |
12/07 09:20:24 Info: [stats] 4995mb Virtual, 2589mb Physical, 1583mb Managed, 0 Handles, 86 Threads | |
12/07 09:20:39 Info: [stats] 4995mb Virtual, 2589mb Physical, 1584mb Managed, 0 Handles, 85 Threads |
Sign up for free
to join this conversation on GitHub.
Already have an account?
Sign in to comment