MM5 will stop on GoogleCast disconnects

Help improve MediaMonkey 5 by testing the latest pre-release builds, and reporting bugs and feature requests.

Moderator: Gurus

Platonius
Posts: 22
Joined: Mon May 25, 2020 9:37 am

MM5 will stop on GoogleCast disconnects

Post by Platonius »

Hi,

I've got a lot of disconnects when GoogleCasting. Most are easily recoverable. When I see the pop-up, I can just click it, set the "Play to" to the same casting device and press play. And it connects and starts playing.

Is it possible to let MM5 recover from these non-fatal errors?

Part below has entry 01980783 that it gracefully disconnected and 01980797 has NPT_ERROR_CONNECTION_RESET.
Would it be possible to have MM5 try and reconnect after that?

Code: Select all

01980738	10:24:59	[5408] MM5 [1796](R) TChromeCastHandler.SendCastMessage(-> JBL (JBL Link Portable)): sender: client-162118, receiver: 9691309f-7b6d-4b75-a559-1a60da54c386, namespace: urn:x-cast:com.google.cast.media , JSON: {"type":"GET_STATUS","requestId":6888}	
01980739	10:25:00	[5408] MM5 [14776](R) TChromeCastHandler.OnCastMessage(<- JBL (JBL Link Portable)): {"type":"MEDIA_STATUS","status":[{"mediaSessionId":13,"playbackRate":1,"playerState":"PLAYING","currentTime":84.841386,"supportedMediaCommands":274447,"volume":{"level":0.58,"muted":false},"activeTrackIds":[],"currentItemId":1,"repeatMode":"REPEAT_OFF"}],"requestId":0}	
01980740	10:25:00	[5408] MM5 [16688](R) TChromecastPlayer.InvokeAction(GetTransportInfo, , ) on JBL	
01980741	10:25:00	[5408] MM5 [16688](R) TChromeCastHandler.SendCastMessage(-> JBL (JBL Link Portable)): sender: client-162118, receiver: 9691309f-7b6d-4b75-a559-1a60da54c386, namespace: urn:x-cast:com.google.cast.media , JSON: {"type":"GET_STATUS","requestId":6889}	
01980742	10:25:01	[5408] MM5 [16688](R) TChromecastPlayer.InvokeAction(GetTransportInfo, , ) on JBL	
01980743	10:25:01	[5408] MM5 [16688](R) TChromeCastHandler.SendCastMessage(-> JBL (JBL Link Portable)): sender: client-162118, receiver: 9691309f-7b6d-4b75-a559-1a60da54c386, namespace: urn:x-cast:com.google.cast.media , JSON: {"type":"GET_STATUS","requestId":6890}	
01980744	10:25:01	[5408] MM5 [16688](R) TChromecastPlayer.InvokeAction(GetTransportInfo, , ) on JBL	
01980745	10:25:01	[5408] MM5 [16688](R) TChromeCastHandler.SendCastMessage(-> JBL (JBL Link Portable)): sender: client-162118, receiver: 9691309f-7b6d-4b75-a559-1a60da54c386, namespace: urn:x-cast:com.google.cast.media , JSON: {"type":"GET_STATUS","requestId":6891}	
01980746	10:25:02	[5408] MM5 [16688](R) TChromecastPlayer.InvokeAction(GetTransportInfo, , ) on JBL	
01980747	10:25:02	[5408] MM5 [16688](R) TChromeCastHandler.SendCastMessage(-> JBL (JBL Link Portable)): sender: client-162118, receiver: 9691309f-7b6d-4b75-a559-1a60da54c386, namespace: urn:x-cast:com.google.cast.media , JSON: {"type":"GET_STATUS","requestId":6892}	
01980748	10:25:02	[5408] MM5 [16688](R) TChromecastPlayer.InvokeAction(GetTransportInfo, , ) on JBL	
01980749	10:25:02	[5408] MM5 [16688](R) TChromeCastHandler.SendCastMessage(-> JBL (JBL Link Portable)): sender: client-162118, receiver: 9691309f-7b6d-4b75-a559-1a60da54c386, namespace: urn:x-cast:com.google.cast.media , JSON: {"type":"GET_STATUS","requestId":6893}	
01980750	10:25:03	[5408] MM5 [16688](R) TChromecastPlayer.InvokeAction(GetTransportInfo, , ) on JBL	
01980751	10:25:03	[5408] MM5 [16688](R) TChromeCastHandler.SendCastMessage(-> JBL (JBL Link Portable)): sender: client-162118, receiver: 9691309f-7b6d-4b75-a559-1a60da54c386, namespace: urn:x-cast:com.google.cast.media , JSON: {"type":"GET_STATUS","requestId":6894}	
01980752	10:25:03	[5408] MM5 [16688](R) TChromecastPlayer.InvokeAction(GetTransportInfo, , ) on JBL	
01980753	10:25:03	[5408] MM5 [16688](R) TChromeCastHandler.SendCastMessage(-> JBL (JBL Link Portable)): sender: client-162118, receiver: 9691309f-7b6d-4b75-a559-1a60da54c386, namespace: urn:x-cast:com.google.cast.media , JSON: {"type":"GET_STATUS","requestId":6895}	
01980754	10:25:04	[5408] MM5 [5808](R) TChromecastPlayer.InvokeAction(GetTransportInfo, , ) on JBL	
01980755	10:25:04	[5408] MM5 [5808](R) TChromeCastHandler.SendCastMessage(-> JBL (JBL Link Portable)): sender: client-162118, receiver: 9691309f-7b6d-4b75-a559-1a60da54c386, namespace: urn:x-cast:com.google.cast.media , JSON: {"type":"GET_STATUS","requestId":6896}	
01980756	10:25:05	[5408] MM5 [16688](R) TChromecastPlayer.InvokeAction(GetTransportInfo, , ) on JBL	
01980757	10:25:05	[5408] MM5 [16688](R) TChromeCastHandler.SendCastMessage(-> JBL (JBL Link Portable)): sender: client-162118, receiver: 9691309f-7b6d-4b75-a559-1a60da54c386, namespace: urn:x-cast:com.google.cast.media , JSON: {"type":"GET_STATUS","requestId":6897}	
01980758	10:25:05	[5408] MM5 [16688](R) TChromecastPlayer.InvokeAction(GetTransportInfo, , ) on JBL	
01980759	10:25:05	[5408] MM5 [16688](R) TChromeCastHandler.SendCastMessage(-> JBL (JBL Link Portable)): sender: client-162118, receiver: 9691309f-7b6d-4b75-a559-1a60da54c386, namespace: urn:x-cast:com.google.cast.media , JSON: {"type":"GET_STATUS","requestId":6898}	
01980760	10:25:06	[5408] MM5 [16688](R) TChromecastPlayer.InvokeAction(GetTransportInfo, , ) on JBL	
01980761	10:25:06	[5408] MM5 [16688](R) TChromeCastHandler.SendCastMessage(-> JBL (JBL Link Portable)): sender: client-162118, receiver: 9691309f-7b6d-4b75-a559-1a60da54c386, namespace: urn:x-cast:com.google.cast.media , JSON: {"type":"GET_STATUS","requestId":6899}	
01980762	10:25:06	[5408] MM5 [16688](R) TChromecastPlayer.InvokeAction(GetTransportInfo, , ) on JBL	
01980763	10:25:06	[5408] MM5 [16688](R) TChromeCastHandler.SendCastMessage(-> JBL (JBL Link Portable)): sender: client-162118, receiver: 9691309f-7b6d-4b75-a559-1a60da54c386, namespace: urn:x-cast:com.google.cast.media , JSON: {"type":"GET_STATUS","requestId":6900}	
01980764	10:25:07	[5408] MM5 [16688](R) TChromecastPlayer.InvokeAction(GetTransportInfo, , ) on JBL	
01980765	10:25:07	[5408] MM5 [16688](R) TChromeCastHandler.SendCastMessage(-> JBL (JBL Link Portable)): sender: client-162118, receiver: 9691309f-7b6d-4b75-a559-1a60da54c386, namespace: urn:x-cast:com.google.cast.media , JSON: {"type":"GET_STATUS","requestId":6901}	
01980766	10:25:07	[5408] MM5 [16688](R) TChromecastPlayer.InvokeAction(GetTransportInfo, , ) on JBL	
01980767	10:25:07	[5408] MM5 [16688](R) TChromeCastHandler.SendCastMessage(-> JBL (JBL Link Portable)): sender: client-162118, receiver: 9691309f-7b6d-4b75-a559-1a60da54c386, namespace: urn:x-cast:com.google.cast.media , JSON: {"type":"GET_STATUS","requestId":6902}	
01980768	10:25:08	[5408] MM5 [5808](R) PostponeComputerSleep: Enabled = 0	
01980769	10:25:08	[5408] MM5 [5808](R) PostponeComputerSleep: SetThreadExecutionState exists	
01980770	10:25:08	[5408] MM5 [16688](R) PostponeComputerSleep: SetThreadExecutionState result = $80000001	
01980771	10:25:08	[5408] MM5 [16688](R) TChromecastPlayer.InvokeAction(GetTransportInfo, , ) on JBL	
01980772	10:25:08	[5408] MM5 [16688](R) TChromeCastHandler.SendCastMessage(-> JBL (JBL Link Portable)): sender: client-162118, receiver: 9691309f-7b6d-4b75-a559-1a60da54c386, namespace: urn:x-cast:com.google.cast.media , JSON: {"type":"GET_STATUS","requestId":6903}	
01980773	10:25:09	[5408] MM5 [16688](R) TChromecastPlayer.InvokeAction(GetTransportInfo, , ) on JBL	
01980774	10:25:09	[5408] MM5 [16688](R) TChromeCastHandler.SendCastMessage(-> JBL (JBL Link Portable)): sender: client-162118, receiver: 9691309f-7b6d-4b75-a559-1a60da54c386, namespace: urn:x-cast:com.google.cast.media , JSON: {"type":"GET_STATUS","requestId":6904}	
01980775	10:25:09	[5408] MM5 [16688](R) TChromecastPlayer.InvokeAction(GetTransportInfo, , ) on JBL	
01980776	10:25:09	[5408] MM5 [16688](R) TChromeCastHandler.SendCastMessage(-> JBL (JBL Link Portable)): sender: client-162118, receiver: 9691309f-7b6d-4b75-a559-1a60da54c386, namespace: urn:x-cast:com.google.cast.media , JSON: {"type":"GET_STATUS","requestId":6905}	
01980777	10:25:10	[5408] MM5 [16688](R) TChromecastPlayer.InvokeAction(GetTransportInfo, , ) on JBL	
01980778	10:25:10	[5408] MM5 [16688](R) TChromeCastHandler.SendCastMessage(-> JBL (JBL Link Portable)): sender: client-162118, receiver: 9691309f-7b6d-4b75-a559-1a60da54c386, namespace: urn:x-cast:com.google.cast.media , JSON: {"type":"GET_STATUS","requestId":6906}	
01980779	10:25:10	[5408] MM5 [14776](R) TChromeCastHandler.OnCastMessage(<- JBL (JBL Link Portable)): {"type":"PING"}	
01980780	10:25:10	[5408] MM5 [14776](R) TChromeCastHandler.SendCastMessage(-> JBL (JBL Link Portable)): sender: client-162118, receiver: 9691309f-7b6d-4b75-a559-1a60da54c386, namespace: urn:x-cast:com.google.cast.tp.heartbeat , JSON: {"type":"PONG"}	
01980781	10:25:10	[5408] MM5 [16688](R) TChromecastPlayer.InvokeAction(GetTransportInfo, , ) on JBL	
01980782	10:25:10	[5408] MM5 [16688](R) TChromeCastHandler.SendCastMessage(-> JBL (JBL Link Portable)): sender: client-162118, receiver: 9691309f-7b6d-4b75-a559-1a60da54c386, namespace: urn:x-cast:com.google.cast.media , JSON: {"type":"GET_STATUS","requestId":6907}	
01980783	10:25:10	[5408] MM5 [16688](R) TChromeCastHandler.SendCastMessage exception: Connection Closed Gracefully. , JSON: {"type":"GET_STATUS","requestId":6907}	
01980784	10:25:11	[5408] MM5 [16688](R) TChromecastPlayer.InvokeAction(GetTransportInfo, , ) on JBL	
01980785	10:25:11	[5408] MM5 [16688](R) TChromecastPlayer.InvokeAction(GetTransportInfo, , ) on JBL	
01980786	10:25:12	[5408] MM5 [16688](R) TChromecastPlayer.InvokeAction(GetTransportInfo, , ) on JBL	
01980787	10:25:13	[5408] MM5 [16688](R) TChromecastPlayer.InvokeAction(GetTransportInfo, , ) on JBL	
01980788	10:25:13	[5408] MM5 [16688](R) TChromecastPlayer.InvokeAction(GetTransportInfo, , ) on JBL	
01980789	10:25:14	[5408] MM5 [16688](R) TChromecastPlayer.InvokeAction(GetTransportInfo, , ) on JBL	
01980790	10:25:14	[5408] MM5 [16688](R) TChromecastPlayer.InvokeAction(GetTransportInfo, , ) on JBL	
01980791	10:25:15	[5408] MM5 [16688](R) TChromecastPlayer.InvokeAction(GetTransportInfo, , ) on JBL	
01980792	10:25:15	[5408] MM5 [16688](R) TChromecastPlayer.InvokeAction(GetTransportInfo, , ) on JBL	
01980793	10:25:16	[5408] MM5 [16688](R) TChromecastPlayer.InvokeAction(GetTransportInfo, , ) on JBL	
01980794	10:25:17	[5408] MM5 [16688](R) TChromecastPlayer.InvokeAction(GetTransportInfo, , ) on JBL	
01980795	10:25:17	[5408] MM5 [16688](R) TChromecastPlayer.InvokeAction(GetTransportInfo, , ) on JBL	
01980796	10:25:18	[5408] MM5 [16688](R) TChromecastPlayer.InvokeAction(GetTransportInfo, , ) on JBL	
01980797	10:25:18	[5408] BytesTransfered: 8847360, EndOffset: 0, result: NPT_ERROR_CONNECTION_RESET	
01980798	10:25:18	[5408] MM5 [16688](R) TChromecastPlayer.InvokeAction(GetTransportInfo, , ) on JBL	
01980799	10:25:19	[5408] MM5 [16688](R) TChromecastPlayer.InvokeAction(GetTransportInfo, , ) on JBL	
01980800	10:25:19	[5408] MM5 [16688](R) JBL seems no longer accessible: LastRequestAgo: 531, LastResponseAgo: 20531	
01980801	10:25:19	[5408] MM5 [16688](R) _Stop: started	
01980802	10:25:19	[5408] MM5 [16688](R) TChromecastPlayer.InvokeAction(GetTransportInfo, , ) on JBL	
01980803	10:25:19	[5408] MM5 [16688](R) TInternalPlayer.Stop - finished	
01980804	10:25:19	[5408] MM5 [16688](R) Player - new state: stop	
01980805	10:25:19	[5408] MM5 [16688](R) last.fm: onPlaybackState stop	
01980806	10:25:19	[5408] MM5 [16688](R) last.fm: not scrobbling, timestamp=1634891016, playedS=103.467, duration=330	
01980807	10:25:19	[5408] MM5 [16688](R) Player - new state: stop	
01980808	10:25:20	[5408] MM5 [16688](R) COM - calling event TSDBApplication.DoTrackPlaybackStopped	
01980809	10:25:20	[5408] MM5 [16688](R) COM - calling event TSDBApplication.DoPlaybackEnd	
01980810	10:25:20	[5408] MM5 [16688](R) _Stop: finished	
01980811	10:25:20	[5408] MM5 [16688](R) COM - calling event TSDBApplication.DoTrackPlaybackStopped	
01980812	10:25:20	[5408] MM5 [16688](R) TChromecastPlayer.InvokeAction(Stop, , ) on JBL	
01980813	10:25:20	[5408] MM5 [16688](R) TChromeCastHandler.CheckConnected: Disconnect and exit	
01980814	10:25:20	[5408] MM5 [16688](R) BQ: Currently running 0 threads of 10	
01980815	10:25:20	[5408] MM5 [16688](R) _Stop: started	
01980816	10:25:20	[5408] MM5 [16688](R) _Stop: already stopped, exiting	
01980817	10:25:20	[5408] MM5 [16688](R) TChromecastPlayer.Disconnect	
Lowlander
Posts: 51451
Joined: Sat Sep 06, 2003 5:53 pm
Location: MediaMonkey 5

Re: MM5 will stop on GoogleCast disconnects

Post by Lowlander »

Which Build (Help > About) are you seeing this with?
Platonius
Posts: 22
Joined: Mon May 25, 2020 9:37 am

Re: MM5 will stop on GoogleCast disconnects

Post by Platonius »

This was 2508, as 2510 didn't work properly for me (would crash en have a 1-entry playlist). But all versions before also have it (since the update to casting in 5.0.2, as before that, it wouldn't reconnect properly).

Now updated to 2511, so we'll see how it goes...
Platonius
Posts: 22
Joined: Mon May 25, 2020 9:37 am

Re: MM5 will stop on GoogleCast disconnects

Post by Platonius »

2511 gives the same error. Gracefully disconnected and NPT_ERROR_CONNECTION_RESET.
Lowlander
Posts: 51451
Joined: Sat Sep 06, 2003 5:53 pm
Location: MediaMonkey 5

Re: MM5 will stop on GoogleCast disconnects

Post by Lowlander »

Please capture this in a full debug log (step 4b) with Build 2511 and attach the log to a Support Ticket: viewtopic.php?f=30&t=86643

This will help a developer analyze why this happens on your setup.
Post Reply