[SOLVED] Google mini stop playing after some time

hi, im running openhab v2.5.1, when i run music on google mini using chromecast binding, the music stop playing after 2 mins… below is the error:

20:51:37.526 [WARN ] [org.eclipse.jetty.server.HttpChannel ] - /audio/78c89593-87bf-4df8-a1c3-d5b43c483ee5 java.io.IOException: java.util.concurrent.TimeoutException: Idle timeout expired: 30000/30000 ms

With limited info I can only recommend you stop OH, clean the cache and reboot.

sudo systemctl stop openhab2

sudo openhab-cli clean-cache

sudo reboot

Note: It will take several minutes for Oh to restart after cleaning the cache.

i did already, thanks for reply… what info u require?

When did it start, have you made any other OH changes, did it work correctly in the past?

i was not using it before, i just upgraded from 2.4 stable to 2.5 stable cause chromecast binding had an issue on 2.4 with audiogroup… so i upgraded to 2.5, installed chromecast binding, audiogroup is working now, but when i play anything on any of my 2 google mini or both, it plays with no issue, but after 2 mins approximately it stop playing, check below log:

21:17:57.082 [INFO ] [smarthome.event.ItemCommandEvent     ] - Item 'music_track' received command 1
21:18:09.366 [INFO ] [smarthome.event.ItemStateChangedEvent] - ChromecastAudioControl_LR changed from PAUSE to PLAY
21:18:43.407 [WARN ] [org.eclipse.jetty.server.HttpChannel ] - /audio/09c52054-720d-4f93-9111-c6efa05d5109 java.io.IOException: java.util.concurrent.TimeoutException: Idle timeout expired: 30000/30000 ms
21:20:31.768 [INFO ] [smarthome.event.ItemStateChangedEvent] - ChromecastAudioControl_LR changed from PLAY to PAUSE

this is exactly when it plays and when its automatically stopped… btw, the track is 8 mins long

Set the binding to DEBUG and/or TRACE via the console and see if any additional info pops up.

Also what are you running OH on, how did you install OH and what version of Java is being used?

here is the log:

21:31:45.949 [INFO ] [smarthome.event.ItemCommandEvent     ] - Item 'music_track' received command 1
21:31:46.148 [DEBUG] [romecast.internal.ChromecastCommander] - Application launched: Application{id: CC1AD845, name: Default Media Receiver, sessionId: c6dd6a7e-8d21-469f-abe8-58f0d4c4b532, statusText: Default Media Receiver, transportId: c6dd6a7e-8d21-469f-abe8-58f0d4c4b532, isIdleScreen: false, launchedFromCloud: false, namespaces: [Namespace{urn:x-cast:com.google.cast.cac}, Namespace{urn:x-cast:com.google.cast.debugoverlay}, Namespace{urn:x-cast:com.google.cast.broadcast}, Namespace{urn:x-cast:com.google.cast.media}]}
21:31:46.649 [DEBUG] [cast.internal.ChromecastStatusUpdater] - MEDIA_STATUS MediaStatus{activeTrackIds: <null>, mediaSessionId: 1, playbackRate: 1, playerState: IDLE, currentItemId: 1, currentTime: 0.000000, customData: <null>, loadingItemId: null, items: <null>, preloadedItemId: null, supportedMediaCommands: 274447, volume: Volume{level: 1.0, muted: false, increment: 0.05, stepInterval: 0.05000000074505806, controlType: null}, media: Media{url: http://192.168.0.10:8080/audio/9c1c4aab-7816-4caf-8de9-0a7deb96beff, contentType: audio/mpeg, duration: null}, repeatMode: REPEAT_OFF, idleReason: null}
21:31:47.721 [DEBUG] [covery.ChromecastDiscoveryParticipant] - Chromecast Type: Google Home Mini
21:31:47.729 [DEBUG] [covery.ChromecastDiscoveryParticipant] - Chromecast Found: 192.168.0.20 8009
21:31:47.736 [DEBUG] [covery.ChromecastDiscoveryParticipant] - Chromecast Type: Google Home Mini
21:31:47.873 [DEBUG] [cast.internal.ChromecastEventReceiver] - Received an 'UNKNOWN' event (class=class com.fasterxml.jackson.databind.JsonNode)
21:31:48.531 [DEBUG] [cast.internal.ChromecastStatusUpdater] - MEDIA_STATUS MediaStatus{activeTrackIds: [], mediaSessionId: 1, playbackRate: 1, playerState: PLAYING, currentItemId: 1, currentTime: 1.029845, customData: <null>, loadingItemId: null, items: <null>, preloadedItemId: null, supportedMediaCommands: 274447, volume: Volume{level: 1.0, muted: false, increment: 0.05, stepInterval: 0.05000000074505806, controlType: null}, media: null, repeatMode: REPEAT_OFF, idleReason: null}
21:31:48.546 [INFO ] [smarthome.event.ItemStateChangedEvent] - ChromecastAudioControl_LR changed from PAUSE to PLAY
21:31:49.705 [DEBUG] [cast.internal.ChromecastStatusUpdater] - MEDIA_STATUS MediaStatus{activeTrackIds: [], mediaSessionId: 1, playbackRate: 1, playerState: PLAYING, currentItemId: 1, currentTime: 2.212240, customData: <null>, loadingItemId: null, items: [Item{id: 1, media: Media{url: http://192.168.0.10:8080/audio/9c1c4aab-7816-4caf-8de9-0a7deb96beff, contentType: audio/mpeg, duration: 509.884082}}], preloadedItemId: null, supportedMediaCommands: 274447, volume: Volume{level: 1.0, muted: false, increment: 0.05, stepInterval: 0.05000000074505806, controlType: null}, media: Media{url: http://192.168.0.10:8080/audio/9c1c4aab-7816-4caf-8de9-0a7deb96beff, contentType: audio/mpeg, duration: 509.884082}, repeatMode: REPEAT_OFF, idleReason: null}
21:32:00.969 [DEBUG] [cast.internal.ChromecastStatusUpdater] - MEDIA_STATUS MediaStatus{activeTrackIds: [], mediaSessionId: 1, playbackRate: 1, playerState: PLAYING, currentItemId: 1, currentTime: 13.492571, customData: <null>, loadingItemId: null, items: [Item{id: 1, media: Media{url: http://192.168.0.10:8080/audio/9c1c4aab-7816-4caf-8de9-0a7deb96beff, contentType: audio/mpeg, duration: 509.884082}}], preloadedItemId: null, supportedMediaCommands: 274447, volume: Volume{level: 1.0, muted: false, increment: 0.05, stepInterval: 0.05000000074505806, controlType: null}, media: Media{url: http://192.168.0.10:8080/audio/9c1c4aab-7816-4caf-8de9-0a7deb96beff, contentType: audio/mpeg, duration: 509.884082}, repeatMode: REPEAT_OFF, idleReason: null}
21:32:11.132 [DEBUG] [cast.internal.ChromecastStatusUpdater] - MEDIA_STATUS MediaStatus{activeTrackIds: [], mediaSessionId: 1, playbackRate: 1, playerState: PLAYING, currentItemId: 1, currentTime: 23.627793, customData: <null>, loadingItemId: null, items: [Item{id: 1, media: Media{url: http://192.168.0.10:8080/audio/9c1c4aab-7816-4caf-8de9-0a7deb96beff, contentType: audio/mpeg, duration: 509.884082}}], preloadedItemId: null, supportedMediaCommands: 274447, volume: Volume{level: 1.0, muted: false, increment: 0.05, stepInterval: 0.05000000074505806, controlType: null}, media: Media{url: http://192.168.0.10:8080/audio/9c1c4aab-7816-4caf-8de9-0a7deb96beff, contentType: audio/mpeg, duration: 509.884082}, repeatMode: REPEAT_OFF, idleReason: null}
21:32:18.458 [WARN ] [org.eclipse.jetty.server.HttpChannel ] - /audio/9c1c4aab-7816-4caf-8de9-0a7deb96beff java.io.IOException: java.util.concurrent.TimeoutException: Idle timeout expired: 30000/30000 ms
21:32:21.325 [DEBUG] [cast.internal.ChromecastStatusUpdater] - MEDIA_STATUS MediaStatus{activeTrackIds: [], mediaSessionId: 1, playbackRate: 1, playerState: PLAYING, currentItemId: 1, currentTime: 33.825429, customData: <null>, loadingItemId: null, items: [Item{id: 1, media: Media{url: http://192.168.0.10:8080/audio/9c1c4aab-7816-4caf-8de9-0a7deb96beff, contentType: audio/mpeg, duration: 509.884082}}], preloadedItemId: null, supportedMediaCommands: 274447, volume: Volume{level: 1.0, muted: false, increment: 0.05, stepInterval: 0.05000000074505806, controlType: null}, media: Media{url: http://192.168.0.10:8080/audio/9c1c4aab-7816-4caf-8de9-0a7deb96beff, contentType: audio/mpeg, duration: 509.884082}, repeatMode: REPEAT_OFF, idleReason: null}
21:32:31.574 [DEBUG] [cast.internal.ChromecastStatusUpdater] - MEDIA_STATUS MediaStatus{activeTrackIds: [], mediaSessionId: 1, playbackRate: 1, playerState: PLAYING, currentItemId: 1, currentTime: 44.076252, customData: <null>, loadingItemId: null, items: [Item{id: 1, media: Media{url: http://192.168.0.10:8080/audio/9c1c4aab-7816-4caf-8de9-0a7deb96beff, contentType: audio/mpeg, duration: 509.884082}}], preloadedItemId: null, supportedMediaCommands: 274447, volume: Volume{level: 1.0, muted: false, increment: 0.05, stepInterval: 0.05000000074505806, controlType: null}, media: Media{url: http://192.168.0.10:8080/audio/9c1c4aab-7816-4caf-8de9-0a7deb96beff, contentType: audio/mpeg, duration: 509.884082}, repeatMode: REPEAT_OFF, idleReason: null}
21:32:41.755 [DEBUG] [cast.internal.ChromecastStatusUpdater] - MEDIA_STATUS MediaStatus{activeTrackIds: [], mediaSessionId: 1, playbackRate: 1, playerState: PLAYING, currentItemId: 1, currentTime: 54.281348, customData: <null>, loadingItemId: null, items: [Item{id: 1, media: Media{url: http://192.168.0.10:8080/audio/9c1c4aab-7816-4caf-8de9-0a7deb96beff, contentType: audio/mpeg, duration: 509.884082}}], preloadedItemId: null, supportedMediaCommands: 274447, volume: Volume{level: 1.0, muted: false, increment: 0.05, stepInterval: 0.05000000074505806, controlType: null}, media: Media{url: http://192.168.0.10:8080/audio/9c1c4aab-7816-4caf-8de9-0a7deb96beff, contentType: audio/mpeg, duration: 509.884082}, repeatMode: REPEAT_OFF, idleReason: null}
21:32:51.945 [DEBUG] [cast.internal.ChromecastStatusUpdater] - MEDIA_STATUS MediaStatus{activeTrackIds: [], mediaSessionId: 1, playbackRate: 1, playerState: PLAYING, currentItemId: 1, currentTime: 64.458584, customData: <null>, loadingItemId: null, items: [Item{id: 1, media: Media{url: http://192.168.0.10:8080/audio/9c1c4aab-7816-4caf-8de9-0a7deb96beff, contentType: audio/mpeg, duration: 509.884082}}], preloadedItemId: null, supportedMediaCommands: 274447, volume: Volume{level: 1.0, muted: false, increment: 0.05, stepInterval: 0.05000000074505806, controlType: null}, media: Media{url: http://192.168.0.10:8080/audio/9c1c4aab-7816-4caf-8de9-0a7deb96beff, contentType: audio/mpeg, duration: 509.884082}, repeatMode: REPEAT_OFF, idleReason: null}
21:33:02.166 [DEBUG] [cast.internal.ChromecastStatusUpdater] - MEDIA_STATUS MediaStatus{activeTrackIds: [], mediaSessionId: 1, playbackRate: 1, playerState: PLAYING, currentItemId: 1, currentTime: 74.695560, customData: <null>, loadingItemId: null, items: [Item{id: 1, media: Media{url: http://192.168.0.10:8080/audio/9c1c4aab-7816-4caf-8de9-0a7deb96beff, contentType: audio/mpeg, duration: 509.884082}}], preloadedItemId: null, supportedMediaCommands: 274447, volume: Volume{level: 1.0, muted: false, increment: 0.05, stepInterval: 0.05000000074505806, controlType: null}, media: Media{url: http://192.168.0.10:8080/audio/9c1c4aab-7816-4caf-8de9-0a7deb96beff, contentType: audio/mpeg, duration: 509.884082}, repeatMode: REPEAT_OFF, idleReason: null}
21:33:11.854 [DEBUG] [cast.internal.ChromecastEventReceiver] - Unhandled event type: APPEVENT
21:33:11.866 [DEBUG] [cast.internal.ChromecastEventReceiver] - Unhandled event type: APPEVENT
21:33:11.918 [DEBUG] [cast.internal.ChromecastStatusUpdater] - MEDIA_STATUS MediaStatus{activeTrackIds: <null>, mediaSessionId: 1, playbackRate: 1, playerState: IDLE, currentItemId: 1, currentTime: 0.000000, customData: <null>, loadingItemId: null, items: <null>, preloadedItemId: null, supportedMediaCommands: 274447, volume: Volume{level: 1.0, muted: false, increment: 0.05, stepInterval: 0.05000000074505806, controlType: null}, media: null, repeatMode: null, idleReason: ERROR}
21:33:12.312 [DEBUG] [cast.internal.ChromecastStatusUpdater] - MEDIA_STATUS null
21:33:12.327 [INFO ] [smarthome.event.ItemStateChangedEvent] - ChromecastAudioControl_LR changed from PLAY to PAUSE
21:33:13.016 [DEBUG] [covery.ChromecastDiscoveryParticipant] - Chromecast Type: Google Home Mini
21:33:13.022 [DEBUG] [covery.ChromecastDiscoveryParticipant] - Chromecast Found: 192.168.0.20 8009
21:33:13.030 [DEBUG] [covery.ChromecastDiscoveryParticipant] - Chromecast Type: Google Home Mini
21:33:22.461 [DEBUG] [cast.internal.ChromecastStatusUpdater] - MEDIA_STATUS null

Do you have this item as part of any groups or is it a stand alone item?

stand alone

Have you set the log to TRACE?

no… ill do

21:53:18.491 [INFO ] [smarthome.event.ItemCommandEvent     ] - Item 'music_track' received command 1
21:53:18.720 [DEBUG] [romecast.internal.ChromecastCommander] - Application launched: Application{id: CC1AD845, name: Default Media Receiver, sessionId: 693521cb-523b-4a40-ad0f-262ad4e1a12d, statusText: Default Media Receiver, transportId: 693521cb-523b-4a40-ad0f-262ad4e1a12d, isIdleScreen: false, launchedFromCloud: false, namespaces: [Namespace{urn:x-cast:com.google.cast.cac}, Namespace{urn:x-cast:com.google.cast.debugoverlay}, Namespace{urn:x-cast:com.google.cast.broadcast}, Namespace{urn:x-cast:com.google.cast.media}]}
21:53:18.748 [DEBUG] [covery.ChromecastDiscoveryParticipant] - Chromecast Type: Google Cast Group
21:53:18.756 [DEBUG] [covery.ChromecastDiscoveryParticipant] - Chromecast Found: 192.168.0.20 42648
21:53:18.762 [DEBUG] [covery.ChromecastDiscoveryParticipant] - Chromecast Type: Google Cast Group
21:53:18.813 [DEBUG] [romecast.internal.ChromecastScheduler] - Canceling connection
21:53:18.821 [DEBUG] [romecast.internal.ChromecastScheduler] - Canceling refresh
21:53:18.840 [WARN ] [su.litvak.chromecast.api.v2.Channel  ] - Got IOException while reading due to stream being closed (stop=true), caused by java.net.SocketException: Socket closed
21:53:18.841 [DEBUG] [st.internal.handler.ChromecastHandler] - portNumber Type is java.math.BigDecimal
21:53:18.862 [DEBUG] [romecast.internal.ChromecastScheduler] - Scheduling connection
21:53:18.863 [INFO ] [ome.event.ThingStatusInfoChangedEvent] - 'chromecast:audiogroup:c2828e86-ff7f-42fc-a649-b65a41f59df8' changed from ONLINE to OFFLINE (COMMUNICATION_ERROR): Connection refused (Connection refused)
21:53:18.869 [DEBUG] [romecast.internal.ChromecastScheduler] - Canceling connection
21:53:18.998 [INFO ] [smarthome.event.ThingUpdatedEvent    ] - Thing 'chromecast:audiogroup:c2828e86-ff7f-42fc-a649-b65a41f59df8' has been updated.
21:53:19.156 [DEBUG] [cast.internal.ChromecastStatusUpdater] - MEDIA_STATUS MediaStatus{activeTrackIds: <null>, mediaSessionId: 1, playbackRate: 1, playerState: IDLE, currentItemId: 1, currentTime: 0.000000, customData: <null>, loadingItemId: null, items: <null>, preloadedItemId: null, supportedMediaCommands: 274447, volume: Volume{level: 1.0, muted: false, increment: 0.05, stepInterval: 0.05000000074505806, controlType: null}, media: Media{url: http://192.168.0.10:8080/audio/91fc0798-3d85-4fa1-b1a2-6e4d6895bc2f, contentType: audio/mpeg, duration: null}, repeatMode: REPEAT_OFF, idleReason: null}
21:53:20.229 [DEBUG] [covery.ChromecastDiscoveryParticipant] - Chromecast Type: Google Home Mini
21:53:20.237 [DEBUG] [covery.ChromecastDiscoveryParticipant] - Chromecast Found: 192.168.0.20 8009
21:53:20.245 [DEBUG] [covery.ChromecastDiscoveryParticipant] - Chromecast Type: Google Home Mini
21:53:20.860 [DEBUG] [cast.internal.ChromecastStatusUpdater] - MEDIA_STATUS MediaStatus{activeTrackIds: [], mediaSessionId: 1, playbackRate: 1, playerState: PLAYING, currentItemId: 1, currentTime: 1.044774, customData: <null>, loadingItemId: null, items: <null>, preloadedItemId: null, supportedMediaCommands: 274447, volume: Volume{level: 1.0, muted: false, increment: 0.05, stepInterval: 0.05000000074505806, controlType: null}, media: null, repeatMode: REPEAT_OFF, idleReason: null}
21:53:20.875 [INFO ] [smarthome.event.ItemStateChangedEvent] - ChromecastAudioControl_LR changed from PAUSE to PLAY
21:53:26.057 [DEBUG] [cast.internal.ChromecastStatusUpdater] - MEDIA_STATUS MediaStatus{activeTrackIds: [], mediaSessionId: 1, playbackRate: 1, playerState: PLAYING, currentItemId: 1, currentTime: 6.258709, customData: <null>, loadingItemId: null, items: [Item{id: 1, media: Media{url: http://192.168.0.10:8080/audio/91fc0798-3d85-4fa1-b1a2-6e4d6895bc2f, contentType: audio/mpeg, duration: 291.395918}}], preloadedItemId: null, supportedMediaCommands: 274447, volume: Volume{level: 1.0, muted: false, increment: 0.05, stepInterval: 0.05000000074505806, controlType: null}, media: Media{url: http://192.168.0.10:8080/audio/91fc0798-3d85-4fa1-b1a2-6e4d6895bc2f, contentType: audio/mpeg, duration: 291.395918}, repeatMode: REPEAT_OFF, idleReason: null}
21:53:28.906 [DEBUG] [romecast.internal.ChromecastScheduler] - Scheduling connection
21:53:28.914 [DEBUG] [romecast.internal.ChromecastScheduler] - Canceling connection
21:53:36.227 [DEBUG] [cast.internal.ChromecastStatusUpdater] - MEDIA_STATUS MediaStatus{activeTrackIds: [], mediaSessionId: 1, playbackRate: 1, playerState: PLAYING, currentItemId: 1, currentTime: 16.434498, customData: <null>, loadingItemId: null, items: [Item{id: 1, media: Media{url: http://192.168.0.10:8080/audio/91fc0798-3d85-4fa1-b1a2-6e4d6895bc2f, contentType: audio/mpeg, duration: 291.395918}}], preloadedItemId: null, supportedMediaCommands: 274447, volume: Volume{level: 1.0, muted: false, increment: 0.05, stepInterval: 0.05000000074505806, controlType: null}, media: Media{url: http://192.168.0.10:8080/audio/91fc0798-3d85-4fa1-b1a2-6e4d6895bc2f, contentType: audio/mpeg, duration: 291.395918}, repeatMode: REPEAT_OFF, idleReason: null}
21:53:38.933 [DEBUG] [romecast.internal.ChromecastScheduler] - Scheduling connection
21:53:38.941 [DEBUG] [romecast.internal.ChromecastScheduler] - Canceling connection
21:53:46.422 [DEBUG] [cast.internal.ChromecastStatusUpdater] - MEDIA_STATUS MediaStatus{activeTrackIds: [], mediaSessionId: 1, playbackRate: 1, playerState: PLAYING, currentItemId: 1, currentTime: 26.629955, customData: <null>, loadingItemId: null, items: [Item{id: 1, media: Media{url: http://192.168.0.10:8080/audio/91fc0798-3d85-4fa1-b1a2-6e4d6895bc2f, contentType: audio/mpeg, duration: 291.395918}}], preloadedItemId: null, supportedMediaCommands: 274447, volume: Volume{level: 1.0, muted: false, increment: 0.05, stepInterval: 0.05000000074505806, controlType: null}, media: Media{url: http://192.168.0.10:8080/audio/91fc0798-3d85-4fa1-b1a2-6e4d6895bc2f, contentType: audio/mpeg, duration: 291.395918}, repeatMode: REPEAT_OFF, idleReason: null}
21:53:48.961 [DEBUG] [romecast.internal.ChromecastScheduler] - Scheduling connection
21:53:48.968 [DEBUG] [romecast.internal.ChromecastScheduler] - Canceling connection
21:53:51.417 [WARN ] [org.eclipse.jetty.server.HttpChannel ] - /audio/91fc0798-3d85-4fa1-b1a2-6e4d6895bc2f java.io.IOException: java.util.concurrent.TimeoutException: Idle timeout expired: 30000/30000 ms
21:53:56.620 [DEBUG] [cast.internal.ChromecastStatusUpdater] - MEDIA_STATUS MediaStatus{activeTrackIds: [], mediaSessionId: 1, playbackRate: 1, playerState: PLAYING, currentItemId: 1, currentTime: 36.825562, customData: <null>, loadingItemId: null, items: [Item{id: 1, media: Media{url: http://192.168.0.10:8080/audio/91fc0798-3d85-4fa1-b1a2-6e4d6895bc2f, contentType: audio/mpeg, duration: 291.395918}}], preloadedItemId: null, supportedMediaCommands: 274447, volume: Volume{level: 1.0, muted: false, increment: 0.05, stepInterval: 0.05000000074505806, controlType: null}, media: Media{url: http://192.168.0.10:8080/audio/91fc0798-3d85-4fa1-b1a2-6e4d6895bc2f, contentType: audio/mpeg, duration: 291.395918}, repeatMode: REPEAT_OFF, idleReason: null}
21:53:58.987 [DEBUG] [romecast.internal.ChromecastScheduler] - Scheduling connection
21:53:58.997 [DEBUG] [romecast.internal.ChromecastScheduler] - Canceling connection
21:54:00.431 [DEBUG] [cast.internal.ChromecastEventReceiver] - Unhandled event type: APPEVENT
21:54:00.440 [DEBUG] [cast.internal.ChromecastEventReceiver] - Unhandled event type: APPEVENT
21:54:00.478 [DEBUG] [cast.internal.ChromecastStatusUpdater] - MEDIA_STATUS MediaStatus{activeTrackIds: <null>, mediaSessionId: 1, playbackRate: 1, playerState: IDLE, currentItemId: 1, currentTime: 0.000000, customData: <null>, loadingItemId: null, items: <null>, preloadedItemId: null, supportedMediaCommands: 274447, volume: Volume{level: 1.0, muted: false, increment: 0.05, stepInterval: 0.05000000074505806, controlType: null}, media: null, repeatMode: null, idleReason: ERROR}
21:54:01.652 [DEBUG] [covery.ChromecastDiscoveryParticipant] - Chromecast Type: Google Home Mini
21:54:01.661 [DEBUG] [covery.ChromecastDiscoveryParticipant] - Chromecast Found: 192.168.0.20 8009
21:54:01.671 [DEBUG] [covery.ChromecastDiscoveryParticipant] - Chromecast Type: Google Home Mini
21:54:06.835 [DEBUG] [cast.internal.ChromecastStatusUpdater] - MEDIA_STATUS null
21:54:06.855 [INFO ] [smarthome.event.ItemStateChangedEvent] - ChromecastAudioControl_LR changed from PLAY to PAUSE
21:54:09.016 [DEBUG] [romecast.internal.ChromecastScheduler] - Scheduling connection
21:54:09.028 [DEBUG] [romecast.internal.ChromecastScheduler] - Canceling connection
21:54:16.986 [DEBUG] [cast.internal.ChromecastStatusUpdater] - MEDIA_STATUS null
21:54:19.043 [DEBUG] [romecast.internal.ChromecastScheduler] - Scheduling connection
21:54:19.051 [DEBUG] [romecast.internal.ChromecastScheduler] - Canceling connection
21:54:27.148 [DEBUG] [cast.internal.ChromecastStatusUpdater] - MEDIA_STATUS null
21:54:29.070 [DEBUG] [romecast.internal.ChromecastScheduler] - Scheduling connection
21:54:29.080 [DEBUG] [romecast.internal.ChromecastScheduler] - Canceling connection
21:54:37.402 [DEBUG] [cast.internal.ChromecastStatusUpdater] - MEDIA_STATUS null
21:54:39.095 [DEBUG] [romecast.internal.ChromecastScheduler] - Scheduling connection
21:54:39.105 [DEBUG] [romecast.internal.ChromecastScheduler] - Canceling connection

From the console check the binding version and while there restart the just the binding.

229 │ Active │ 80 │ 2.5.1 │ org.openhab.binding.chromecast

Use bundle:update first then bundle:restart

EDIT:

Uninstall the binding via PaperUI then add the 2.5.2 jar file, in link below, to your addons folder and restart OH.
https://openhab.jfrog.io/openhab/libs-pullrequest-local/org/openhab/addons/bundles/org.openhab.binding.chromecast/

For apt-get install the location to place jar file is: usr/share/openhab2/addons

229 │ Active │ 80 │ 2.5.1 │ org.openhab.binding.chromecast

after update and restart…thanks for support again

@Mohammad_Chaaban: See my edit in post above.

i uninstalled… i added the new… do i need to clear the cache and restart

22:18:03.055 [WARN ] [org.apache.felix.fileinstall         ] - Error while starting bundle: file:/usr/share/openhab2/addons/org.openhab.binding.chromecast-2.5.2-SNAPSHOT.jar
org.osgi.framework.BundleException: Could not resolve module: org.openhab.binding.chromecast [252]
  Unresolved requirement: Import-Package: com.fasterxml.jackson.annotation; version="[2.9.0,3.0.0)"

        at org.eclipse.osgi.container.Module.start(Module.java:444) ~[org.eclipse.osgi-3.12.100.jar:?]
        at org.eclipse.osgi.internal.framework.EquinoxBundle.start(EquinoxBundle.java:383) ~[org.eclipse.osgi-3.12.100.jar:?]
        at org.apache.felix.fileinstall.internal.DirectoryWatcher.startBundle(DirectoryWatcher.java:1260) [bundleFile:3.6.4]
        at org.apache.felix.fileinstall.internal.DirectoryWatcher.startBundles(DirectoryWatcher.java:1233) [bundleFile:3.6.4]
        at org.apache.felix.fileinstall.internal.DirectoryWatcher.doProcess(DirectoryWatcher.java:520) [bundleFile:3.6.4]
        at org.apache.felix.fileinstall.internal.DirectoryWatcher.process(DirectoryWatcher.java:365) [bundleFile:3.6.4]
        at org.apache.felix.fileinstall.internal.DirectoryWatcher.run(DirectoryWatcher.java:316) [bundleFile:3.6.4]

Yes I would clean cache and restart.

[22:20:12] openhabian@openhab:~$ sudo systemctl stop openhab2
[sudo] password for openhabian:
[22:20:39] openhabian@openhab:~$ sudo openhab-cli clean-cache

This command will delete the temporary files within openHAB.
May resolve issues with addon installation and configuration.
openHAB is running! Please stop the process before continuing.

any idea why i cant clear the cache i already stopped openhab