Mar 28 12:13:04 volumio volumio[1230]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 28 12:13:05 volumio bluealsa[897]: bluez.c:1290: Signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded(/org/bluez/hci0/dev_72_30_5B_BC_56_97, ...) Mar 28 12:13:09 volumio bluealsa[897]: bluez.c:1393: Signal: org.freedesktop.DBus.ObjectManager.InterfacesRemoved(/org/bluez/hci0/dev_6D_13_C2_DB_0C_93, ...) Mar 28 12:13:13 volumio bluealsa[897]: bluez.c:1290: Signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded(/org/bluez/hci0/dev_63_EA_E0_0C_D7_47, ...) Mar 28 12:13:13 volumio volumio[1230]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 28 12:13:13 volumio volumio[1230]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Mar 28 12:13:13 volumio volumio[1230]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Mar 28 12:13:13 volumio volumio[1230]: info: Received Get System Version Mar 28 12:13:13 volumio volumio[1230]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 28 12:13:13 volumio volumio[1230]: info: Received Get System Info Mar 28 12:13:13 volumio volumio[1230]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 28 12:13:13 volumio volumio[1230]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 28 12:13:13 volumio volumio[1230]: info: Discovery: Getting this device information Mar 28 12:13:13 volumio volumio[1230]: info: CoreCommandRouter::volumioGetState Mar 28 12:13:13 volumio volumio[1230]: info: CorePlayQueue::getTrack 0 Mar 28 12:13:13 volumio volumio[1230]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 28 12:13:21 volumio volumio[1230]: info: CALLMETHOD: music_service ytcr refreshUIConfig [object Object] Mar 28 12:13:21 volumio volumio[1230]: info: CoreCommandRouter::executeOnPlugin: ytcr , refreshUIConfig Mar 28 12:13:21 volumio volumio[1230]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 28 12:13:24 volumio bluealsa[897]: bluez.c:1290: Signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded(/org/bluez/hci0/dev_5D_F4_B5_93_46_CC, ...) Mar 28 12:13:29 volumio bluealsa[897]: bluez.c:1393: Signal: org.freedesktop.DBus.ObjectManager.InterfacesRemoved(/org/bluez/hci0/dev_7B_6E_85_98_02_80, ...) Mar 28 12:13:31 volumio bluealsa[897]: bluez.c:1290: Signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded(/org/bluez/hci0/dev_41_58_13_9B_77_24, ...) Mar 28 12:13:32 volumio volumio[1230]: info: [yt-cast-receiver] (YouTube) Sender connected: SAMSUNG SM-S918B (user: Bruno) Mar 28 12:13:32 volumio volumio[1230]: info: [ytcr] ***** Sender connected ***** Mar 28 12:13:32 volumio volumio[1230]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 28 12:13:35 volumio volumio5-onboarding[1647]: time=2026-03-28T12:13:35.272Z level=INFO msg="new address was allocated" component=ble/conn old=11 new=12 Mar 28 12:13:35 volumio dbus-daemon[684]: [system] Rejected send message, 0 matched rules; type="error", sender=":1.20" (uid=0 pid=1647 comm="/usr/bin/volumio5-onboarding") interface="(unset)" member="(unset)" error name="org.freedesktop.DBus.Error.UnknownMethod" requested_reply="0" destination=":1.4" (uid=0 pid=808 comm="/usr/libexec/bluetooth/bluetoothd --noplugin=sap,b") Mar 28 12:13:41 volumio volumio[1230]: [YOUTUBEJS][Player]: Failed to extract signature decipher function. Mar 28 12:13:41 volumio volumio[1230]: [YOUTUBEJS][Player]: Failed to extract n decipher function. Mar 28 12:13:41 volumio volumio[1230]: info: [yt-cast-receiver] Player.resume() Mar 28 12:13:41 volumio volumio[1230]: info: [yt-cast-receiver] Player.play(): rXJTgMssUxA @ 0s Mar 28 12:13:41 volumio volumio[1230]: info: CoreCommandRouter::volumioGetState Mar 28 12:13:41 volumio volumio[1230]: info: CorePlayQueue::getTrack 0 Mar 28 12:13:41 volumio volumio[1230]: info: CoreCommandRouter::volumioGetState Mar 28 12:13:41 volumio volumio[1230]: info: CorePlayQueue::getTrack 0 Mar 28 12:13:41 volumio volumio[1230]: info: CoreCommandRouter::volumioStop Mar 28 12:13:41 volumio volumio[1230]: info: CoreStateMachine::stop Mar 28 12:13:41 volumio volumio[1230]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 28 12:13:41 volumio volumio[1230]: info: CoreStateMachine::updateTrackBlock Mar 28 12:13:41 volumio volumio[1230]: info: CorePlayQueue::getTrackBlock Mar 28 12:13:41 volumio volumio[1230]: info: CoreStateMachine::stPlaybackTimer Mar 28 12:13:41 volumio volumio[1230]: info: CoreStateMachine::pushState Mar 28 12:13:41 volumio volumio[1230]: info: CorePlayQueue::getTrack 0 Mar 28 12:13:41 volumio volumio[1230]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 12:13:41 volumio volumio[1230]: info: CoreCommandRouter::volumioPushState Mar 28 12:13:41 volumio volumio[1230]: info: CoreStateMachine::serviceStop Mar 28 12:13:41 volumio volumio[1230]: info: CorePlayQueue::getTrack 0 Mar 28 12:13:41 volumio volumio[1230]: info: CoreCommandRouter::serviceStop Mar 28 12:13:41 volumio volumio[1230]: error: WARNING: No stop method for service ytmusic Mar 28 12:13:41 volumio volumio[1230]: info: CoreCommandRouter::volumioGetState Mar 28 12:13:41 volumio volumio[1230]: info: CorePlayQueue::getTrack 0 Mar 28 12:13:41 volumio volumio[1230]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 28 12:13:41 volumio volumio[1230]: info: CoreCommandRouter::servicePushState Mar 28 12:13:41 volumio volumio[1230]: info: CoreStateMachine::pushState Mar 28 12:13:41 volumio volumio[1230]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 12:13:41 volumio volumio[1230]: info: CoreCommandRouter::volumioPushState Mar 28 12:13:41 volumio volumio[1230]: info: CoreCommandRouter::servicePushState Mar 28 12:13:41 volumio volumio[1230]: info: CoreStateMachine::pushState Mar 28 12:13:41 volumio volumio[1230]: info: CoreCommandRouter::volumioPushState Mar 28 12:13:41 volumio volumio[1230]: info: [ytcr] Innertube support service: Deno not installed or otherwise failed to start: Command failed: npx --no-install --yes deno --version Mar 28 12:13:41 volumio volumio[1230]: info: [ytcr] Innertube support service: Start service with Node Mar 28 12:13:41 volumio volumio5-onboarding[1647]: time=2026-03-28T12:13:41.300Z level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%0a @ 0x2a8f350" state=STATUS_STOPPED positionMs=0 volume=100 Mar 28 12:13:41 volumio volumio5-onboarding[1647]: time=2026-03-28T12:13:41.301Z level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%0a @ 0x2a8f350" state=STATUS_PAUSED positionMs=0 volume=100 Mar 28 12:13:41 volumio volumio5-onboarding[1647]: time=2026-03-28T12:13:41.301Z level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%0a @ 0x2a8f350" state=STATUS_PAUSED positionMs=0 volume=100 Mar 28 12:13:41 volumio volumio[1230]: info: CoreCommandRouter::volumioGetState Mar 28 12:13:41 volumio volumio[1230]: info: CoreCommandRouter::servicePushState Mar 28 12:13:41 volumio volumio[1230]: info: CoreStateMachine::pushState Mar 28 12:13:41 volumio volumio[1230]: info: CoreCommandRouter::volumioPushState Mar 28 12:13:41 volumio volumio[1230]: info: CorePlayQueue::getTrack 0 Mar 28 12:13:41 volumio volumio[1230]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current ytmusic Received ytcr Mar 28 12:13:41 volumio volumio5-onboarding[1647]: time=2026-03-28T12:13:41.346Z level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%0a @ 0x2a8f350" state=STATUS_PAUSED positionMs=0 volume=100 Mar 28 12:13:42 volumio bluealsa[897]: bluez.c:1393: Signal: org.freedesktop.DBus.ObjectManager.InterfacesRemoved(/org/bluez/hci0/dev_72_30_5B_BC_56_97, ...) Mar 28 12:13:42 volumio volumio[1230]: info: [yt-cast-receiver] Player.stop() Mar 28 12:13:42 volumio volumio[1230]: info: CoreCommandRouter::volumioGetState Mar 28 12:13:42 volumio volumio[1230]: info: CoreCommandRouter::servicePushState Mar 28 12:13:42 volumio volumio[1230]: info: CoreStateMachine::pushState Mar 28 12:13:42 volumio volumio[1230]: info: CoreCommandRouter::volumioPushState Mar 28 12:13:42 volumio volumio[1230]: info: [yt-cast-receiver] Player.play(): rXJTgMssUxA @ 49s Mar 28 12:13:42 volumio volumio[1230]: info: CoreCommandRouter::volumioGetState Mar 28 12:13:42 volumio volumio[1230]: info: CoreCommandRouter::volumioGetState Mar 28 12:13:42 volumio volumio5-onboarding[1647]: time=2026-03-28T12:13:42.883Z level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%0a @ 0x2a8f350" state=STATUS_PAUSED positionMs=0 volume=100 Mar 28 12:13:44 volumio volumio5-onboarding[1647]: time=2026-03-28T12:13:44.667Z level=WARN msg="pending write exceeded maximum retries, dropping" component=ble/conn addr=10 chunks=1 index=0 tries=11 Mar 28 12:13:44 volumio volumio5-onboarding[1647]: time=2026-03-28T12:13:44.667Z level=ERROR msg="failed to send event" component=server dst="00:00:00:00:00:00%0a @ 0x2a8f350" event=SERVER_EVENT_TYPE_PLAYER_STATE_CHANGED error="peer is gone" Mar 28 12:13:44 volumio volumio5-onboarding[1647]: time=2026-03-28T12:13:44.667Z level=INFO msg="emitting player state changed event" component=server peer="192.168.1.10:47794 @ 0x28a8b70" state=STATUS_STOPPED positionMs=0 volume=100 Mar 28 12:13:44 volumio volumio5-onboarding[1647]: time=2026-03-28T12:13:44.668Z level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%0b @ 0x2c20900" state=STATUS_STOPPED positionMs=0 volume=100 Mar 28 12:13:45 volumio volumio[1230]: info: [ytcr] Innertube support service: result: {"status":"started","server":{"address":"127.0.0.1","port":37491}} Mar 28 12:13:45 volumio volumio[1230]: info: [ytcr] Innertube support service running at http://127.0.0.1:37491 Mar 28 12:13:47 volumio volumio5-onboarding[1647]: time=2026-03-28T12:13:47.123Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.10:47794 @ 0x28a8b70" id="ytmusic/song@explodeTrackData:o=%7B%22type%22%3A%22song%22%2C%22title%22%3A%22Scent%20of%20Dark%22%2C%22artist%22%3A%22Tony%20Iommi%22%2C%22album%22%3A%22%22%2C%22albumart%22%3A%22https%3A%2F%2Flh3.googleusercontent.com%2F2H3fmZi34yFjs1SMOFN2TWKj5px0vHkSk9QCkGoTuY2tktwFsh9I4LwsWzyw8Bs3bEPrfCsaTFFTs-Sc%3Dw701-h701-l90-rj%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22LTs7GcA1YKQ%22%2C%22playlistId%22%3A%22OLAK5uy_kEyin0-728lzrKY5KPEOgB1is4rHUrIIc%22%2C%22index%22%3A0%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22playlistId%22%3A%22OLAK5uy_kEyin0-728lzrKY5KPEOgB1is4rHUrIIc%22%2C%22videoId%22%3A%22MpE-U6f524c%22%7D%7D%7D%7D" title="Scent of Dark" Mar 28 12:13:47 volumio volumio5-onboarding[1647]: time=2026-03-28T12:13:47.125Z level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%0b @ 0x2c20900" id="ytmusic/song@explodeTrackData:o=%7B%22type%22%3A%22song%22%2C%22title%22%3A%22Scent%20of%20Dark%22%2C%22artist%22%3A%22Tony%20Iommi%22%2C%22album%22%3A%22%22%2C%22albumart%22%3A%22https%3A%2F%2Flh3.googleusercontent.com%2F2H3fmZi34yFjs1SMOFN2TWKj5px0vHkSk9QCkGoTuY2tktwFsh9I4LwsWzyw8Bs3bEPrfCsaTFFTs-Sc%3Dw701-h701-l90-rj%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22LTs7GcA1YKQ%22%2C%22playlistId%22%3A%22OLAK5uy_kEyin0-728lzrKY5KPEOgB1is4rHUrIIc%22%2C%22index%22%3A0%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22playlistId%22%3A%22OLAK5uy_kEyin0-728lzrKY5KPEOgB1is4rHUrIIc%22%2C%22videoId%22%3A%22MpE-U6f524c%22%7D%7D%7D%7D" title="Scent of Dark" Mar 28 12:13:48 volumio volumio5-onboarding[1647]: time=2026-03-28T12:13:48.112Z level=WARN msg="pending write exceeded maximum retries, dropping" component=ble/conn addr=10 chunks=1 index=0 tries=11 Mar 28 12:13:48 volumio volumio5-onboarding[1647]: time=2026-03-28T12:13:48.113Z level=ERROR msg="failed to send event" component=server dst="00:00:00:00:00:00%0a @ 0x2a8f350" event=SERVER_EVENT_TYPE_PLAYER_STATE_CHANGED error="peer is gone" Mar 28 12:13:48 volumio volumio5-onboarding[1647]: time=2026-03-28T12:13:48.113Z level=INFO msg="emitting player state changed event" component=server peer="192.168.1.10:47794 @ 0x28a8b70" state=STATUS_PAUSED positionMs=0 volume=100 Mar 28 12:13:48 volumio volumio5-onboarding[1647]: time=2026-03-28T12:13:48.115Z level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%0b @ 0x2c20900" state=STATUS_PAUSED positionMs=0 volume=100 Mar 28 12:13:49 volumio volumio5-onboarding[1647]: time=2026-03-28T12:13:49.792Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.10:47794 @ 0x28a8b70" id= title= Mar 28 12:13:49 volumio volumio5-onboarding[1647]: time=2026-03-28T12:13:49.792Z level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%0b @ 0x2c20900" id= title= Mar 28 12:13:51 volumio volumio5-onboarding[1647]: time=2026-03-28T12:13:51.682Z level=WARN msg="pending write exceeded maximum retries, dropping" component=ble/conn addr=10 chunks=1 index=0 tries=11 Mar 28 12:13:51 volumio volumio5-onboarding[1647]: time=2026-03-28T12:13:51.682Z level=ERROR msg="failed to send event" component=server dst="00:00:00:00:00:00%0a @ 0x2a8f350" event=SERVER_EVENT_TYPE_PLAYER_STATE_CHANGED error="peer is gone" Mar 28 12:13:51 volumio volumio5-onboarding[1647]: time=2026-03-28T12:13:51.683Z level=INFO msg="emitting player state changed event" component=server peer="192.168.1.10:47794 @ 0x28a8b70" state=STATUS_PAUSED positionMs=0 volume=100 Mar 28 12:13:51 volumio volumio5-onboarding[1647]: time=2026-03-28T12:13:51.687Z level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%0b @ 0x2c20900" state=STATUS_PAUSED positionMs=0 volume=100 Mar 28 12:13:52 volumio bluealsa[897]: bluez.c:1393: Signal: org.freedesktop.DBus.ObjectManager.InterfacesRemoved(/org/bluez/hci0/dev_63_EA_E0_0C_D7_47, ...) Mar 28 12:13:52 volumio volumio5-onboarding[1647]: time=2026-03-28T12:13:52.104Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.10:47794 @ 0x28a8b70" id= title= Mar 28 12:13:52 volumio volumio5-onboarding[1647]: time=2026-03-28T12:13:52.104Z level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%0b @ 0x2c20900" id= title= Mar 28 12:13:52 volumio volumio[1230]: [YOUTUBEJS][Player]: Failed to extract signature decipher function. Mar 28 12:13:52 volumio volumio[1230]: [YOUTUBEJS][Player]: Failed to extract n decipher function. Mar 28 12:13:52 volumio volumio[1230]: info: [yt-cast-receiver] (YouTube) Sender disconnected: SAMSUNG SM-S918B Mar 28 12:13:52 volumio volumio[1230]: info: [yt-cast-receiver] Player.reset() Mar 28 12:13:52 volumio volumio[1230]: info: [yt-cast-receiver] Player.stop() Mar 28 12:13:52 volumio volumio[1230]: info: CoreCommandRouter::volumioGetState Mar 28 12:13:52 volumio volumio[1230]: info: CoreCommandRouter::servicePushState Mar 28 12:13:52 volumio volumio[1230]: info: CoreStateMachine::pushState Mar 28 12:13:52 volumio volumio[1230]: info: CoreCommandRouter::volumioPushState Mar 28 12:13:52 volumio volumio[1230]: info: CoreCommandRouter::servicePushState Mar 28 12:13:52 volumio volumio[1230]: info: CoreStateMachine::pushState Mar 28 12:13:52 volumio volumio[1230]: info: CoreCommandRouter::volumioPushState Mar 28 12:13:52 volumio volumio[1230]: info: [ytcr] ***** Sender disconnected ***** Mar 28 12:13:52 volumio volumio[1230]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 28 12:13:52 volumio volumio[1230]: info: CoreCommandRouter::volumioGetState Mar 28 12:13:52 volumio volumio[1230]: info: CoreCommandRouter::servicePushState Mar 28 12:13:52 volumio volumio[1230]: info: CoreStateMachine::pushState Mar 28 12:13:52 volumio volumio[1230]: info: CoreCommandRouter::volumioPushState Mar 28 12:13:52 volumio volumio[1230]: info: CoreCommandRouter::servicePushState Mar 28 12:13:52 volumio volumio[1230]: info: CoreStateMachine::pushState Mar 28 12:13:52 volumio volumio[1230]: info: CoreCommandRouter::volumioPushState Mar 28 12:13:52 volumio volumio5-onboarding[1647]: time=2026-03-28T12:13:52.623Z level=INFO msg="emitting player state changed event" component=server peer="192.168.1.10:47794 @ 0x28a8b70" state=STATUS_PAUSED positionMs=0 volume=100 Mar 28 12:13:52 volumio volumio5-onboarding[1647]: time=2026-03-28T12:13:52.623Z level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%0b @ 0x2c20900" state=STATUS_PAUSED positionMs=0 volume=100 Mar 28 12:13:52 volumio volumio5-onboarding[1647]: time=2026-03-28T12:13:52.634Z level=INFO msg="emitting player state changed event" component=server peer="192.168.1.10:47794 @ 0x28a8b70" state=STATUS_PAUSED positionMs=0 volume=100 Mar 28 12:13:52 volumio volumio5-onboarding[1647]: time=2026-03-28T12:13:52.634Z level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%0b @ 0x2c20900" state=STATUS_PAUSED positionMs=0 volume=100 Mar 28 12:13:52 volumio volumio5-onboarding[1647]: time=2026-03-28T12:13:52.638Z level=INFO msg="emitting player state changed event" component=server peer="192.168.1.10:47794 @ 0x28a8b70" state=STATUS_PAUSED positionMs=0 volume=100 Mar 28 12:13:52 volumio volumio5-onboarding[1647]: time=2026-03-28T12:13:52.639Z level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%0b @ 0x2c20900" state=STATUS_PAUSED positionMs=0 volume=100 Mar 28 12:13:52 volumio volumio5-onboarding[1647]: time=2026-03-28T12:13:52.641Z level=INFO msg="emitting player state changed event" component=server peer="192.168.1.10:47794 @ 0x28a8b70" state=STATUS_PAUSED positionMs=0 volume=100 Mar 28 12:13:52 volumio volumio5-onboarding[1647]: time=2026-03-28T12:13:52.641Z level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%0b @ 0x2c20900" state=STATUS_PAUSED positionMs=0 volume=100 Mar 28 12:13:52 volumio volumio[1230]: info: [yt-cast-receiver] Connecting sender through DIAL... Mar 28 12:13:53 volumio volumio[1230]: info: [yt-cast-receiver] (YouTube) Sender connected: SAMSUNG SM-S918B (user: Bruno) Mar 28 12:13:53 volumio volumio[1230]: info: [ytcr] ***** Sender connected ***** Mar 28 12:13:53 volumio volumio[1230]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 28 12:13:53 volumio volumio5-onboarding[1647]: time=2026-03-28T12:13:53.727Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.10:47794 @ 0x28a8b70" id= title= Mar 28 12:13:53 volumio volumio5-onboarding[1647]: time=2026-03-28T12:13:53.727Z level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%0b @ 0x2c20900" id= title= Mar 28 12:13:53 volumio volumio5-onboarding[1647]: time=2026-03-28T12:13:53.815Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.10:47794 @ 0x28a8b70" id= title= Mar 28 12:13:53 volumio volumio5-onboarding[1647]: time=2026-03-28T12:13:53.816Z level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%0b @ 0x2c20900" id= title= Mar 28 12:13:54 volumio volumio[1230]: info: [ytcr] Obtained session PO token using visitorData (expires in 43199 seconds) Mar 28 12:13:55 volumio volumio5-onboarding[1647]: time=2026-03-28T12:13:55.324Z level=WARN msg="pending write exceeded maximum retries, dropping" component=ble/conn addr=10 chunks=1 index=0 tries=11 Mar 28 12:13:55 volumio volumio5-onboarding[1647]: time=2026-03-28T12:13:55.325Z level=ERROR msg="failed to send event" component=server dst="00:00:00:00:00:00%0a @ 0x2a8f350" event=SERVER_EVENT_TYPE_PLAYER_STATE_CHANGED error="peer is gone" Mar 28 12:13:55 volumio volumio5-onboarding[1647]: time=2026-03-28T12:13:55.325Z level=INFO msg="emitting player state changed event" component=server peer="192.168.1.10:47794 @ 0x28a8b70" state=STATUS_PAUSED positionMs=0 volume=100 Mar 28 12:13:55 volumio volumio5-onboarding[1647]: time=2026-03-28T12:13:55.325Z level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%0b @ 0x2c20900" state=STATUS_PAUSED positionMs=0 volume=100 Mar 28 12:13:55 volumio volumio5-onboarding[1647]: time=2026-03-28T12:13:55.376Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.10:47794 @ 0x28a8b70" id= title= Mar 28 12:13:55 volumio volumio5-onboarding[1647]: time=2026-03-28T12:13:55.376Z level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%0b @ 0x2c20900" id= title= Mar 28 12:13:55 volumio volumio5-onboarding[1647]: time=2026-03-28T12:13:55.732Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.10:47794 @ 0x28a8b70" id= title= Mar 28 12:13:55 volumio volumio5-onboarding[1647]: time=2026-03-28T12:13:55.733Z level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%0b @ 0x2c20900" id= title= Mar 28 12:13:57 volumio volumio5-onboarding[1647]: time=2026-03-28T12:13:57.445Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.10:47794 @ 0x28a8b70" id= title= Mar 28 12:13:57 volumio volumio5-onboarding[1647]: time=2026-03-28T12:13:57.445Z level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%0b @ 0x2c20900" id= title= Mar 28 12:13:59 volumio volumio5-onboarding[1647]: time=2026-03-28T12:13:59.041Z level=WARN msg="pending write exceeded maximum retries, dropping" component=ble/conn addr=10 chunks=1 index=0 tries=11 Mar 28 12:13:59 volumio volumio5-onboarding[1647]: time=2026-03-28T12:13:59.041Z level=ERROR msg="failed to send event" component=server dst="00:00:00:00:00:00%0a @ 0x2a8f350" event=SERVER_EVENT_TYPE_PLAYER_STATE_CHANGED error="peer is gone" Mar 28 12:13:59 volumio volumio5-onboarding[1647]: time=2026-03-28T12:13:59.042Z level=INFO msg="emitting player state changed event" component=server peer="192.168.1.10:47794 @ 0x28a8b70" state=STATUS_PAUSED positionMs=0 volume=100 Mar 28 12:13:59 volumio volumio5-onboarding[1647]: time=2026-03-28T12:13:59.042Z level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%0b @ 0x2c20900" state=STATUS_PAUSED positionMs=0 volume=100 Mar 28 12:13:59 volumio volumio5-onboarding[1647]: time=2026-03-28T12:13:59.272Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.10:47794 @ 0x28a8b70" id= title= Mar 28 12:13:59 volumio volumio5-onboarding[1647]: time=2026-03-28T12:13:59.272Z level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%0b @ 0x2c20900" id= title= Mar 28 12:14:00 volumio bluealsa[897]: bluez.c:1393: Signal: org.freedesktop.DBus.ObjectManager.InterfacesRemoved(/org/bluez/hci0/dev_5D_F4_B5_93_46_CC, ...) Mar 28 12:14:01 volumio volumio[1230]: [YOUTUBEJS][Player]: Failed to extract signature decipher function. Mar 28 12:14:01 volumio volumio[1230]: [YOUTUBEJS][Player]: Failed to extract n decipher function. Mar 28 12:14:01 volumio volumio[1230]: info: [ytcr] Going to refresh session PO token in 43099 seconds Mar 28 12:14:01 volumio volumio[1230]: error: [yt-cast-receiver] Caught error handling incoming message: Mar 28 12:14:01 volumio volumio[1230]: (TypeError) fetch failed Mar 28 12:14:01 volumio volumio[1230]: TypeError: fetch failed Mar 28 12:14:01 volumio volumio[1230]: at Object.fetch (node:internal/deps/undici/undici:11576:11) Mar 28 12:14:01 volumio volumio[1230]: at async InnertubeWrapper.generatePoToken (/data/plugins/music_service/ytcr/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:100:17) Mar 28 12:14:01 volumio volumio[1230]: at async InnertubeLoader.generatePoToken (/data/plugins/music_service/ytcr/dist/lib/InnertubeLoader.js:42:16) Mar 28 12:14:01 volumio volumio[1230]: at async VideoLoader.getInfo (/data/plugins/music_service/ytcr/dist/lib/VideoLoader.js:94:33) Mar 28 12:14:01 volumio volumio[1230]: at async MPDPlayer.doPlay (/data/plugins/music_service/ytcr/dist/lib/MPDPlayer.js:71:25) Mar 28 12:14:01 volumio volumio[1230]: at async MPDPlayer.play (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/lib/Player.js:62:24) Mar 28 12:14:01 volumio volumio[1230]: at async YouTubeApp._YouTubeApp_handleIncomingMessage (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/lib/app/YouTubeApp.js:488:13) Mar 28 12:14:01 volumio volumio[1230]: at async YouTubeApp._YouTubeApp_handleIncomingMessage (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/lib/app/YouTubeApp.js:302:13) Mar 28 12:14:01 volumio volumio[1230]: info: [yt-cast-receiver] Player.resume() Mar 28 12:14:01 volumio volumio[1230]: info: [yt-cast-receiver] Player.play(): rXJTgMssUxA @ 0s Mar 28 12:14:01 volumio volumio[1230]: info: CoreCommandRouter::volumioGetState Mar 28 12:14:01 volumio volumio[1230]: info: CoreCommandRouter::volumioGetState Mar 28 12:14:01 volumio volumio[1230]: info: CoreCommandRouter::volumioGetState Mar 28 12:14:01 volumio volumio[1230]: info: CoreCommandRouter::servicePushState Mar 28 12:14:01 volumio volumio[1230]: info: CoreStateMachine::pushState Mar 28 12:14:01 volumio volumio[1230]: info: CoreCommandRouter::volumioPushState Mar 28 12:14:01 volumio volumio5-onboarding[1647]: time=2026-03-28T12:14:01.560Z level=INFO msg="emitting player state changed event" component=server peer="192.168.1.10:47794 @ 0x28a8b70" state=STATUS_PAUSED positionMs=0 volume=100 Mar 28 12:14:01 volumio volumio5-onboarding[1647]: time=2026-03-28T12:14:01.560Z level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%0b @ 0x2c20900" state=STATUS_PAUSED positionMs=0 volume=100 Mar 28 12:14:01 volumio volumio5-onboarding[1647]: time=2026-03-28T12:14:01.642Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.10:47794 @ 0x28a8b70" id= title= Mar 28 12:14:01 volumio volumio5-onboarding[1647]: time=2026-03-28T12:14:01.648Z level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%0b @ 0x2c20900" id= title= Mar 28 12:14:07 volumio volumio[1230]: [YOUTUBEJS][Player]: Failed to extract signature decipher function. Mar 28 12:14:07 volumio volumio[1230]: [YOUTUBEJS][Player]: Failed to extract n decipher function. Mar 28 12:14:07 volumio volumio[1230]: info: [ytcr] (rXJTgMssUxA) fetching player data using YTMUSIC client... Mar 28 12:14:08 volumio volumio[1230]: error: [ytcr] Error in VideoLoader.getInfo(rXJTgMssUxA): Mar 28 12:14:08 volumio volumio[1230]: (SyntaxError) Unexpected token '<', ") Mar 28 12:14:08 volumio volumio[1230]: at parseJSONFromBytes (node:internal/deps/undici/undici:6662:19) Mar 28 12:14:08 volumio volumio[1230]: at successSteps (node:internal/deps/undici/undici:6636:27) Mar 28 12:14:08 volumio volumio[1230]: at node:internal/deps/undici/undici:1236:60 Mar 28 12:14:08 volumio volumio[1230]: at node:internal/process/task_queues:140:7 Mar 28 12:14:08 volumio volumio[1230]: at AsyncResource.runInAsyncScope (node:async_hooks:206:9) Mar 28 12:14:08 volumio volumio[1230]: at AsyncResource.runMicrotask (node:internal/process/task_queues:137:8) Mar 28 12:14:08 volumio volumio[1230]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Mar 28 12:14:08 volumio volumio[1230]: error: [ytcr] Innertube support service: TypeError: exportedVars.nFunction is not a function Mar 28 12:14:08 volumio volumio[1230]: at eval (eval at evalFnImpl (/data/plugins/music_service/ytcr/node_modules/volumio-yt-support/dist/lib/innertube/Service.js:29:12), :16:26) Mar 28 12:14:08 volumio volumio[1230]: at evalFnImpl (/data/plugins/music_service/ytcr/node_modules/volumio-yt-support/dist/lib/innertube/Service.js:29:26) Mar 28 12:14:08 volumio volumio[1230]: at Object.evalFn (/data/plugins/music_service/ytcr/node_modules/volumio-yt-support/dist/lib/innertube/Service.js:65:48) Mar 28 12:14:08 volumio volumio[1230]: at /data/plugins/music_service/ytcr/node_modules/volumio-yt-support/dist/lib/innertube/Server.js:96:96 Mar 28 12:14:08 volumio volumio[1230]: at Layer.handleRequest (/data/plugins/music_service/ytcr/node_modules/router/lib/layer.js:152:17) Mar 28 12:14:08 volumio volumio[1230]: at next (/data/plugins/music_service/ytcr/node_modules/router/lib/route.js:157:13) Mar 28 12:14:08 volumio volumio[1230]: at Route.dispatch (/data/plugins/music_service/ytcr/node_modules/router/lib/route.js:117:3) Mar 28 12:14:08 volumio volumio[1230]: at handle (/data/plugins/music_service/ytcr/node_modules/router/index.js:435:11) Mar 28 12:14:08 volumio volumio[1230]: at Layer.handleRequest (/data/plugins/music_service/ytcr/node_modules/router/lib/layer.js:152:17) Mar 28 12:14:08 volumio volumio[1230]: at /data/plugins/music_service/ytcr/node_modules/router/index.js:295:15 Mar 28 12:14:08 volumio volumio[1230]: info: CoreCommandRouter::volumioGetState Mar 28 12:14:08 volumio volumio[1230]: info: CoreCommandRouter::servicePushState Mar 28 12:14:08 volumio volumio[1230]: info: CoreStateMachine::pushState Mar 28 12:14:08 volumio volumio[1230]: info: CoreCommandRouter::volumioPushState Mar 28 12:14:08 volumio volumio5-onboarding[1647]: time=2026-03-28T12:14:08.221Z level=INFO msg="emitting player state changed event" component=server peer="192.168.1.10:47794 @ 0x28a8b70" state=STATUS_PAUSED positionMs=0 volume=100 Mar 28 12:14:08 volumio volumio5-onboarding[1647]: time=2026-03-28T12:14:08.221Z level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%0b @ 0x2c20900" state=STATUS_PAUSED positionMs=0 volume=100 Mar 28 12:14:08 volumio volumio[1230]: info: Ignoring MPD Status Update Mar 28 12:14:08 volumio volumio[1230]: info: Ignoring MPD Status Update Mar 28 12:14:08 volumio volumio5-onboarding[1647]: time=2026-03-28T12:14:08.272Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.10:47794 @ 0x28a8b70" id= title= Mar 28 12:14:08 volumio volumio5-onboarding[1647]: time=2026-03-28T12:14:08.273Z level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%0b @ 0x2c20900" id= title= Mar 28 12:14:09 volumio volumio[1230]: info: [yt-cast-receiver] Player.play(): rXJTgMssUxA @ 0s Mar 28 12:14:09 volumio volumio[1230]: info: CoreCommandRouter::volumioGetState Mar 28 12:14:09 volumio volumio[1230]: info: CoreCommandRouter::volumioGetState Mar 28 12:14:10 volumio volumio[1230]: info: [ytcr] (rXJTgMssUxA) fetching player data using YTMUSIC client... Mar 28 12:14:10 volumio volumio[1230]: error: [ytcr] Error in VideoLoader.getInfo(rXJTgMssUxA): Mar 28 12:14:10 volumio volumio[1230]: (SyntaxError) Unexpected token '<', ") Mar 28 12:14:10 volumio volumio[1230]: at parseJSONFromBytes (node:internal/deps/undici/undici:6662:19) Mar 28 12:14:10 volumio volumio[1230]: at successSteps (node:internal/deps/undici/undici:6636:27) Mar 28 12:14:10 volumio volumio[1230]: at node:internal/deps/undici/undici:1236:60 Mar 28 12:14:10 volumio volumio[1230]: at node:internal/process/task_queues:140:7 Mar 28 12:14:10 volumio volumio[1230]: at AsyncResource.runInAsyncScope (node:async_hooks:206:9) Mar 28 12:14:10 volumio volumio[1230]: at AsyncResource.runMicrotask (node:internal/process/task_queues:137:8) Mar 28 12:14:10 volumio volumio[1230]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Mar 28 12:14:10 volumio volumio[1230]: error: [ytcr] Innertube support service: TypeError: exportedVars.nFunction is not a function Mar 28 12:14:10 volumio volumio[1230]: at eval (eval at evalFnImpl (/data/plugins/music_service/ytcr/node_modules/volumio-yt-support/dist/lib/innertube/Service.js:29:12), :16:26) Mar 28 12:14:10 volumio volumio[1230]: at evalFnImpl (/data/plugins/music_service/ytcr/node_modules/volumio-yt-support/dist/lib/innertube/Service.js:29:26) Mar 28 12:14:10 volumio volumio[1230]: at Object.evalFn (/data/plugins/music_service/ytcr/node_modules/volumio-yt-support/dist/lib/innertube/Service.js:65:48) Mar 28 12:14:10 volumio volumio[1230]: at /data/plugins/music_service/ytcr/node_modules/volumio-yt-support/dist/lib/innertube/Server.js:96:96 Mar 28 12:14:10 volumio volumio[1230]: at Layer.handleRequest (/data/plugins/music_service/ytcr/node_modules/router/lib/layer.js:152:17) Mar 28 12:14:10 volumio volumio[1230]: at next (/data/plugins/music_service/ytcr/node_modules/router/lib/route.js:157:13) Mar 28 12:14:10 volumio volumio[1230]: at Route.dispatch (/data/plugins/music_service/ytcr/node_modules/router/lib/route.js:117:3) Mar 28 12:14:10 volumio volumio[1230]: at handle (/data/plugins/music_service/ytcr/node_modules/router/index.js:435:11) Mar 28 12:14:10 volumio volumio[1230]: at Layer.handleRequest (/data/plugins/music_service/ytcr/node_modules/router/lib/layer.js:152:17) Mar 28 12:14:10 volumio volumio[1230]: at /data/plugins/music_service/ytcr/node_modules/router/index.js:295:15 Mar 28 12:14:10 volumio volumio[1230]: info: CoreCommandRouter::volumioGetState Mar 28 12:14:10 volumio volumio[1230]: info: CoreCommandRouter::servicePushState Mar 28 12:14:10 volumio volumio[1230]: info: CoreStateMachine::pushState Mar 28 12:14:10 volumio volumio[1230]: info: CoreCommandRouter::volumioPushState Mar 28 12:14:10 volumio volumio5-onboarding[1647]: time=2026-03-28T12:14:10.573Z level=INFO msg="emitting player state changed event" component=server peer="192.168.1.10:47794 @ 0x28a8b70" state=STATUS_PAUSED positionMs=0 volume=100 Mar 28 12:14:10 volumio volumio5-onboarding[1647]: time=2026-03-28T12:14:10.573Z level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%0b @ 0x2c20900" state=STATUS_PAUSED positionMs=0 volume=100 Mar 28 12:14:10 volumio volumio[1230]: info: Ignoring MPD Status Update Mar 28 12:14:10 volumio volumio[1230]: info: Ignoring MPD Status Update Mar 28 12:14:10 volumio volumio5-onboarding[1647]: time=2026-03-28T12:14:10.642Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.10:47794 @ 0x28a8b70" id= title= Mar 28 12:14:10 volumio volumio5-onboarding[1647]: time=2026-03-28T12:14:10.644Z level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%0b @ 0x2c20900" id= title= Mar 28 12:14:42 volumio volumio[1230]: info: CALLMETHOD: music_service ytcr configSaveOther [object Object] Mar 28 12:14:42 volumio volumio[1230]: info: CoreCommandRouter::executeOnPlugin: ytcr , configSaveOther Mar 28 12:14:42 volumio volumio[1230]: info: CALLMETHOD: music_service ytcr configSaveOther [object Object] Mar 28 12:14:42 volumio volumio[1230]: info: CoreCommandRouter::executeOnPlugin: ytcr , configSaveOther Mar 28 12:14:42 volumio volumio[1230]: info: CALLMETHOD: music_service ytcr configSaveOther [object Object] Mar 28 12:14:42 volumio volumio[1230]: info: CoreCommandRouter::executeOnPlugin: ytcr , configSaveOther Mar 28 12:14:42 volumio volumio[1230]: info: CALLMETHOD: music_service ytcr configSaveOther [object Object] Mar 28 12:14:42 volumio volumio[1230]: info: CoreCommandRouter::executeOnPlugin: ytcr , configSaveOther Mar 28 12:14:42 volumio volumio[1230]: info: CALLMETHOD: music_service ytcr configSaveOther [object Object] Mar 28 12:14:42 volumio volumio[1230]: info: CoreCommandRouter::executeOnPlugin: ytcr , configSaveOther Mar 28 12:14:42 volumio volumio[1230]: info: CALLMETHOD: music_service ytcr configSaveOther [object Object] Mar 28 12:14:42 volumio volumio[1230]: info: CoreCommandRouter::executeOnPlugin: ytcr , configSaveOther Mar 28 12:14:42 volumio volumio[1230]: info: CALLMETHOD: music_service ytcr configSaveOther [object Object] Mar 28 12:14:42 volumio volumio[1230]: info: CoreCommandRouter::executeOnPlugin: ytcr , configSaveOther Mar 28 12:14:42 volumio volumio[1230]: info: CALLMETHOD: music_service ytcr configSaveOther [object Object] Mar 28 12:14:42 volumio volumio[1230]: info: CoreCommandRouter::executeOnPlugin: ytcr , configSaveOther Mar 28 12:14:42 volumio volumio[1230]: info: CALLMETHOD: music_service ytcr configSaveOther [object Object] Mar 28 12:14:42 volumio volumio[1230]: info: CoreCommandRouter::executeOnPlugin: ytcr , configSaveOther Mar 28 12:14:42 volumio volumio[1230]: info: CALLMETHOD: music_service ytcr configSaveOther [object Object] Mar 28 12:14:42 volumio volumio[1230]: info: CoreCommandRouter::executeOnPlugin: ytcr , configSaveOther Mar 28 12:14:42 volumio volumio[1230]: info: CALLMETHOD: music_service ytcr configSaveOther [object Object] Mar 28 12:14:42 volumio volumio[1230]: info: CoreCommandRouter::executeOnPlugin: ytcr , configSaveOther Mar 28 12:14:42 volumio volumio[1230]: info: CALLMETHOD: music_service ytcr configSaveOther [object Object] Mar 28 12:14:42 volumio volumio[1230]: info: CoreCommandRouter::executeOnPlugin: ytcr , configSaveOther Mar 28 12:14:42 volumio volumio[1230]: info: CALLMETHOD: music_service ytcr configSaveOther [object Object] Mar 28 12:14:42 volumio volumio[1230]: info: CoreCommandRouter::executeOnPlugin: ytcr , configSaveOther Mar 28 12:14:42 volumio volumio[1230]: info: CALLMETHOD: music_service ytcr configSaveOther [object Object] Mar 28 12:14:42 volumio volumio[1230]: info: CoreCommandRouter::executeOnPlugin: ytcr , configSaveOther Mar 28 12:14:42 volumio volumio[1230]: info: CoreCommandRouter::volumioPlay Mar 28 12:14:42 volumio volumio[1230]: verbose: UNSET VOLATILE: Service: ytcr Mar 28 12:14:42 volumio volumio[1230]: info: CoreCommandRouter::servicePushState Mar 28 12:14:42 volumio volumio[1230]: info: CoreStateMachine::pushState Mar 28 12:14:42 volumio volumio[1230]: info: CoreCommandRouter::volumioPushState Mar 28 12:14:42 volumio volumio[1230]: info: CoreCommandRouter::servicePushState Mar 28 12:14:42 volumio volumio[1230]: info: CoreStateMachine::pushState Mar 28 12:14:42 volumio volumio[1230]: info: CoreCommandRouter::volumioPushState Mar 28 12:14:42 volumio volumio[1230]: info: CoreStateMachine::play index undefined Mar 28 12:14:42 volumio volumio[1230]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 28 12:14:42 volumio volumio[1230]: info: CoreCommandRouter::volumioNext Mar 28 12:14:42 volumio volumio[1230]: info: CoreStateMachine::next Mar 28 12:14:42 volumio volumio[1230]: info: CoreStateMachine::stop Mar 28 12:14:42 volumio volumio[1230]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 28 12:14:42 volumio volumio[1230]: info: CoreStateMachine::updateTrackBlock Mar 28 12:14:42 volumio volumio[1230]: info: CorePlayQueue::getTrackBlock Mar 28 12:14:42 volumio volumio[1230]: info: CoreStateMachine::stPlaybackTimer Mar 28 12:14:42 volumio volumio[1230]: info: CoreStateMachine::pushState Mar 28 12:14:42 volumio volumio[1230]: info: CorePlayQueue::getTrack 0 Mar 28 12:14:42 volumio volumio[1230]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 12:14:42 volumio volumio[1230]: info: CoreCommandRouter::volumioPushState Mar 28 12:14:42 volumio volumio[1230]: info: CoreStateMachine::serviceStop Mar 28 12:14:42 volumio volumio[1230]: info: CorePlayQueue::getTrack 0 Mar 28 12:14:42 volumio volumio[1230]: info: CoreCommandRouter::serviceStop Mar 28 12:14:42 volumio volumio[1230]: error: WARNING: No stop method for service ytmusic Mar 28 12:14:42 volumio volumio[1230]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 28 12:14:42 volumio volumio[1230]: TypeError: Cannot read properties of undefined (reading 'then') Mar 28 12:14:42 volumio volumio[1230]: at CoreStateMachine.next (/volumio/app/statemachine.js:1181:9) Mar 28 12:14:42 volumio volumio[1230]: at CoreCommandRouter.volumioNext (/volumio/app/index.js:103:28) Mar 28 12:14:42 volumio volumio[1230]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:274:26) Mar 28 12:14:42 volumio volumio[1230]: at Socket.emit (node:events:514:28) Mar 28 12:14:42 volumio volumio[1230]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Mar 28 12:14:42 volumio volumio[1230]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) Mar 28 12:14:42 volumio volumio[1230]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 28 12:14:43 volumio sudo[5754]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-03-28 12:13' Mar 28 12:14:43 volumio sudo[5754]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"