-- Logs begin at Thu 2019-02-14 10:11:58 GMT, end at Sun 2025-05-04 14:55:34 BST. -- May 04 14:54:01 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 04 14:54:01 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 04 14:54:10 volumio volumio[1089]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/ytmusic/volumio/buster/armhf May 04 14:54:13 volumio volumio[1089]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/ytmusic/volumio/buster/armhf May 04 14:54:13 volumio volumio[1089]: info: Folder /tmp/plugins removed May 04 14:54:14 volumio volumio[1089]: info: Check plugin dependencies May 04 14:54:14 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 04 14:54:14 volumio volumio[1089]: info: Checking if plugin already exists May 04 14:54:14 volumio volumio[1089]: info: Rename folder May 04 14:54:14 volumio volumio[1089]: info: Folder /tmp/downloaded_plugin.zip removed May 04 14:54:14 volumio volumio[1089]: info: Move to category May 04 14:54:23 volumio volumio-remote-updater[2270]: [2025-05-04 13:54:23] [disconnect] Disconnect close local:[1008,Pong timeout] remote:[1006] May 04 14:54:28 volumio volumio-remote-updater[2270]: [2025-05-04 13:54:28] [connect] Successful connection May 04 14:54:40 volumio volumio-remote-updater[2270]: [2025-05-04 13:54:40] [connect] Successful connection May 04 14:54:54 volumio volumio[1089]: info: Checking if install.sh is present May 04 14:54:54 volumio volumio[1089]: info: Executing install.sh May 04 14:54:54 volumio volumio[1089]: verbose: New Socket.io Connection to 192.168.0.40 from 192.168.0.16 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 May 04 14:54:54 volumio volumio[1089]: verbose: New Socket.io Connection to 192.168.0.40 from 192.168.0.16 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 May 04 14:54:54 volumio sudo[5810]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/music_service/ytmusic/install.sh May 04 14:54:54 volumio sudo[5810]: pam_unix(sudo:session): session opened for user root by (uid=0) May 04 14:54:54 volumio sudo[5810]: pam_unix(sudo:session): session closed for user root May 04 14:54:54 volumio volumio[1089]: verbose: New Socket.io Connection to 192.168.0.40 from 192.168.0.16 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 May 04 14:54:54 volumio volumio[1089]: verbose: New Socket.io Connection to 192.168.0.40 from 192.168.0.16 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 May 04 14:54:54 volumio volumio[1089]: verbose: New Socket.io Connection to 192.168.0.40 from 192.168.0.16 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 May 04 14:54:54 volumio volumio[1089]: verbose: New Socket.io Connection to 192.168.0.40 from 192.168.0.16 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 May 04 14:54:54 volumio volumio[1089]: info: Install script completed May 04 14:54:54 volumio volumio[1089]: info: Adding reference to registry May 04 14:54:54 volumio volumio[1089]: info: Done installing plugin. May 04 14:54:54 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 04 14:54:54 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 04 14:54:54 volumio volumio[1089]: info: Folder /tmp/plugins removed May 04 14:54:54 volumio volumio[1089]: info: Folder /tmp/downloaded_plugin.zip removed May 04 14:54:54 volumio volumio[1089]: info: YouTube Music plugin installed May 04 14:54:54 volumio volumio[1089]: Plugin install end detected on script May 04 14:54:54 volumio volumio[1089]: info: Folder /data/temp removed May 04 14:54:55 volumio volumio[1089]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 May 04 14:54:55 volumio volumio[1089]: verbose: New Socket.io Connection to 192.168.0.40 from 192.168.0.16 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:54:55 volumio volumio[1089]: info: Received Get System Info May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 04 14:54:55 volumio volumio[1089]: info: Discovery: Getting this device information May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:54:55 volumio volumio[1089]: info: Received Get System Info May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 04 14:54:55 volumio volumio[1089]: info: Discovery: Getting this device information May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::volumioGetVisibleSources May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 04 14:54:55 volumio volumio[1089]: info: Received Get System Info May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 04 14:54:55 volumio volumio[1089]: info: Discovery: Getting this device information May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:54:55 volumio volumio[1089]: info: Listing playlists May 04 14:54:55 volumio volumio[1089]: info: Received Get System Info May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 04 14:54:55 volumio volumio[1089]: info: Discovery: Getting this device information May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::volumioGetQueue May 04 14:54:55 volumio volumio[1089]: info: CoreStateMachine::getQueue May 04 14:54:55 volumio volumio[1089]: info: CorePlayQueue::getQueue May 04 14:54:55 volumio volumio[1089]: info: Received Get System Info May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 04 14:54:55 volumio volumio[1089]: info: Discovery: Getting this device information May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::volumioGetVisibleSources May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 04 14:54:55 volumio volumio[1089]: info: Received Get System Info May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 04 14:54:55 volumio volumio[1089]: info: Discovery: Getting this device information May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:54:55 volumio volumio[1089]: info: Listing playlists May 04 14:54:55 volumio volumio[1089]: info: Received Get System Info May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 04 14:54:55 volumio volumio[1089]: info: Discovery: Getting this device information May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::volumioGetQueue May 04 14:54:55 volumio volumio[1089]: info: CoreStateMachine::getQueue May 04 14:54:55 volumio volumio[1089]: info: CorePlayQueue::getQueue May 04 14:54:55 volumio volumio[1089]: info: Received Get System Info May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 04 14:54:55 volumio volumio[1089]: info: Discovery: Getting this device information May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::volumioGetVisibleSources May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 04 14:54:55 volumio volumio[1089]: info: Received Get System Info May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 04 14:54:55 volumio volumio[1089]: info: Discovery: Getting this device information May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:54:55 volumio volumio[1089]: info: Listing playlists May 04 14:54:55 volumio volumio[1089]: info: Received Get System Info May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 04 14:54:55 volumio volumio[1089]: info: Discovery: Getting this device information May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::volumioGetQueue May 04 14:54:55 volumio volumio[1089]: info: CoreStateMachine::getQueue May 04 14:54:55 volumio volumio[1089]: info: CorePlayQueue::getQueue May 04 14:54:55 volumio volumio[1089]: info: Received Get System Info May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 04 14:54:55 volumio volumio[1089]: info: Discovery: Getting this device information May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::volumioGetVisibleSources May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 04 14:54:55 volumio volumio[1089]: info: Received Get System Info May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 04 14:54:55 volumio volumio[1089]: info: Discovery: Getting this device information May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:54:55 volumio volumio[1089]: info: Listing playlists May 04 14:54:55 volumio volumio[1089]: info: Received Get System Info May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 04 14:54:55 volumio volumio[1089]: info: Discovery: Getting this device information May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::volumioGetQueue May 04 14:54:55 volumio volumio[1089]: info: CoreStateMachine::getQueue May 04 14:54:55 volumio volumio[1089]: info: CorePlayQueue::getQueue May 04 14:54:55 volumio volumio[1089]: info: Received Get System Info May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 04 14:54:55 volumio volumio[1089]: info: Discovery: Getting this device information May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::volumioGetVisibleSources May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 04 14:54:55 volumio volumio[1089]: info: Received Get System Info May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 04 14:54:55 volumio volumio[1089]: info: Discovery: Getting this device information May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:54:55 volumio volumio[1089]: info: Listing playlists May 04 14:54:55 volumio volumio[1089]: info: Received Get System Info May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 04 14:54:55 volumio volumio[1089]: info: Discovery: Getting this device information May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::volumioGetQueue May 04 14:54:55 volumio volumio[1089]: info: CoreStateMachine::getQueue May 04 14:54:55 volumio volumio[1089]: info: CorePlayQueue::getQueue May 04 14:54:55 volumio volumio[1089]: info: Received Get System Info May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 04 14:54:55 volumio volumio[1089]: info: Discovery: Getting this device information May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 04 14:54:55 volumio volumio-remote-updater[2270]: [2025-05-04 13:54:55] [connect] Successful connection May 04 14:54:55 volumio volumio[1089]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 9 May 04 14:54:55 volumio volumio-remote-updater[2270]: [2025-05-04 13:54:55] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1746366895 101 May 04 14:54:55 volumio volumio[1089]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 May 04 14:54:55 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:55:06 volumio volumio[1089]: info: [yt-cast-receiver] Player.reset() May 04 14:55:06 volumio volumio[1089]: info: [yt-cast-receiver] Connecting sender through DIAL... May 04 14:55:06 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:55:06 volumio volumio[1089]: info: CoreCommandRouter::servicePushState May 04 14:55:06 volumio volumio[1089]: info: CoreStateMachine::pushState May 04 14:55:06 volumio volumio[1089]: info: CoreCommandRouter::volumioPushState May 04 14:55:06 volumio volumio[1089]: info: CoreCommandRouter::servicePushState May 04 14:55:06 volumio volumio[1089]: info: CoreStateMachine::pushState May 04 14:55:06 volumio volumio[1089]: info: CoreCommandRouter::volumioPushState May 04 14:55:06 volumio volumio[1089]: info: [yt-cast-receiver] (YouTube) Sender connected: G’s iPhone (user: Myst1cPlays) May 04 14:55:06 volumio volumio[1089]: info: [ytcr] ***** Sender connected ***** May 04 14:55:06 volumio volumio[1089]: info: CoreCommandRouter::getUIConfigOnPlugin May 04 14:55:08 volumio volumio[1089]: [YOUTUBEJS][Player]: Failed to extract signature decipher algorithm. May 04 14:55:12 volumio volumio[1089]: info: [yt-cast-receiver] Player.play(): Lm2z1JEKx2U @ 0s May 04 14:55:12 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:55:12 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:55:12 volumio volumio[1089]: info: [yt-cast-receiver] Player.pause() May 04 14:55:13 volumio volumio[1089]: info: Ignoring MPD Status Update May 04 14:55:13 volumio volumio[1089]: info: Ignoring MPD Status Update May 04 14:55:13 volumio volumio[1089]: info: Ignoring MPD Status Update May 04 14:55:13 volumio volumio[1089]: info: Ignoring MPD Status Update May 04 14:55:13 volumio volumio[1089]: info: Ignoring MPD Status Update May 04 14:55:13 volumio volumio[1089]: info: Ignoring MPD Status Update May 04 14:55:13 volumio volumio[1089]: info: Ignoring MPD Status Update May 04 14:55:13 volumio volumio[1089]: info: Ignoring MPD Status Update May 04 14:55:14 volumio volumio[1089]: error: [ytcr] MPD error: May 04 14:55:14 volumio volumio[1089]: (MPDError) Failed to decode https://rr3---sn-cn3tc-cimd.googlevideo.com/videoplayback?expire=1746388513&ei=wXEXaPa0DODdp-oP44jnoA4&ip=2.123.174.250&id=o-AOBkziaDaErP1Ktojgb9m6InFYhcFkc4iiUhZpc455UM&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1746366913%2C&mh=4m&mm=31%2C29&mn=sn-cn3tc-cimd%2Csn-aigl6nze&ms=au%2Crdu&mv=m&mvi=3&pl=22&rms=au%2Cau&initcwndbps=2796250&siu=1&bui=AecWEAZCyIAJlX2rpwr-MgSaP8CigJTSD1ltx48Drsdq02xmiy2C5MTMUbYeiXhohdC6VWRO9A&spc=wk1kZh3hj6OX&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=ZyK6EoxF_M_npeUu5r5GdUgQ&rqh=1&gir=yes&clen=26398728&dur=1649.461&lmt=1740168502863610&mt=1746366577&fvip=2&keepalive=yes&lmw=1&c=TVHTML5&sefc=1&txp=4432534&n=x9lLudIDJ2rzCoNhQj7OyC&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&sig=AJfQdSswRgIhAJpo_2vyqJ9abNIkegEzQKZwuPI17yEvIzGxyUvEQ8T8AiEAu2h0UWMx5hiHX46P37Heh59zEOMo1QdVsIAA6rJB_pE%3D&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=ACu; got HTTP status 403 May 04 14:55:14 volumio volumio[1089]: MPDError: Failed to decode https://rr3---sn-cn3tc-cimd.googlevideo.com/videoplayback?expire=1746388513&ei=wXEXaPa0DODdp-oP44jnoA4&ip=2.123.174.250&id=o-AOBkziaDaErP1Ktojgb9m6InFYhcFkc4iiUhZpc455UM&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1746366913%2C&mh=4m&mm=31%2C29&mn=sn-cn3tc-cimd%2Csn-aigl6nze&ms=au%2Crdu&mv=m&mvi=3&pl=22&rms=au%2Cau&initcwndbps=2796250&siu=1&bui=AecWEAZCyIAJlX2rpwr-MgSaP8CigJTSD1ltx48Drsdq02xmiy2C5MTMUbYeiXhohdC6VWRO9A&spc=wk1kZh3hj6OX&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=ZyK6EoxF_M_npeUu5r5GdUgQ&rqh=1&gir=yes&clen=26398728&dur=1649.461&lmt=1740168502863610&mt=1746366577&fvip=2&keepalive=yes&lmw=1&c=TVHTML5&sefc=1&txp=4432534&n=x9lLudIDJ2rzCoNhQj7OyC&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&sig=AJfQdSswRgIhAJpo_2vyqJ9abNIkegEzQKZwuPI17yEvIzGxyUvEQ8T8AiEAu2h0UWMx5hiHX46P37Heh59zEOMo1QdVsIAA6rJB_pE%3D&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=ACu; got HTTP status 403 May 04 14:55:14 volumio volumio[1089]: at MPDClient._receive (/data/plugins/music_service/ytcr/node_modules/mpd2/lib/index.js:147:24) May 04 14:55:14 volumio volumio[1089]: at Socket.emit (events.js:315:20) May 04 14:55:14 volumio volumio[1089]: at addChunk (internal/streams/readable.js:309:12) May 04 14:55:14 volumio volumio[1089]: at readableAddChunk (internal/streams/readable.js:280:11) May 04 14:55:14 volumio volumio[1089]: at Socket.Readable.push (internal/streams/readable.js:223:10) May 04 14:55:14 volumio volumio[1089]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) May 04 14:55:14 volumio volumio[1089]: info: Ignoring MPD Status Update May 04 14:55:14 volumio volumio[1089]: info: Ignoring MPD Status Update May 04 14:55:14 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:55:14 volumio volumio[1089]: info: CoreCommandRouter::servicePushState May 04 14:55:14 volumio volumio[1089]: info: CoreStateMachine::pushState May 04 14:55:14 volumio volumio[1089]: info: CoreCommandRouter::volumioPushState May 04 14:55:16 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:55:19 volumio volumio[1089]: info: CoreCommandRouter::volumioVolatilePlay May 04 14:55:19 volumio volumio[1089]: info: CoreStateMachine::volatilePlay May 04 14:55:19 volumio volumio[1089]: info: [yt-cast-receiver] Player.resume() May 04 14:55:19 volumio volumio[1089]: info: [yt-cast-receiver] Player.play(): Lm2z1JEKx2U @ 0s May 04 14:55:19 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:55:19 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:55:19 volumio ntpd[995]: 129.250.35.251 local addr 192.168.0.40 -> May 04 14:55:19 volumio volumio[1089]: info: CoreCommandRouter::volumioVolatilePlay May 04 14:55:19 volumio volumio[1089]: info: CoreStateMachine::volatilePlay May 04 14:55:19 volumio volumio[1089]: info: [yt-cast-receiver] Player.resume() May 04 14:55:19 volumio volumio[1089]: info: [yt-cast-receiver] Player.play(): Lm2z1JEKx2U @ 0s May 04 14:55:19 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:55:19 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:55:20 volumio volumio[1089]: info: CoreCommandRouter::volumioVolatilePlay May 04 14:55:20 volumio volumio[1089]: info: CoreStateMachine::volatilePlay May 04 14:55:20 volumio volumio[1089]: info: [yt-cast-receiver] Player.resume() May 04 14:55:20 volumio volumio[1089]: info: [yt-cast-receiver] Player.play(): Lm2z1JEKx2U @ 0s May 04 14:55:20 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:55:20 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:55:20 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:55:20 volumio volumio[1089]: info: CoreCommandRouter::servicePushState May 04 14:55:20 volumio volumio[1089]: info: CoreStateMachine::pushState May 04 14:55:20 volumio volumio[1089]: info: CoreCommandRouter::volumioPushState May 04 14:55:20 volumio volumio[1089]: info: CoreCommandRouter::volumioVolatilePlay May 04 14:55:20 volumio volumio[1089]: info: CoreStateMachine::volatilePlay May 04 14:55:20 volumio volumio[1089]: info: [yt-cast-receiver] Player.resume() May 04 14:55:20 volumio volumio[1089]: info: [yt-cast-receiver] Player.play(): Lm2z1JEKx2U @ 0s May 04 14:55:20 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:55:20 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:55:20 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:55:20 volumio volumio[1089]: info: CoreCommandRouter::servicePushState May 04 14:55:20 volumio volumio[1089]: info: CoreStateMachine::pushState May 04 14:55:20 volumio volumio[1089]: info: CoreCommandRouter::volumioPushState May 04 14:55:21 volumio volumio[1089]: info: Ignoring MPD Status Update May 04 14:55:21 volumio volumio[1089]: info: Ignoring MPD Status Update May 04 14:55:21 volumio volumio[1089]: info: Ignoring MPD Status Update May 04 14:55:21 volumio volumio[1089]: info: Ignoring MPD Status Update May 04 14:55:21 volumio volumio[1089]: info: Ignoring MPD Status Update May 04 14:55:21 volumio volumio[1089]: info: Ignoring MPD Status Update May 04 14:55:21 volumio volumio[1089]: info: Ignoring MPD Status Update May 04 14:55:21 volumio volumio[1089]: info: Ignoring MPD Status Update May 04 14:55:21 volumio volumio[1089]: error: [ytcr] MPD error: May 04 14:55:21 volumio volumio[1089]: (MPDError) Failed to decode https://rr3---sn-cn3tc-cimd.googlevideo.com/videoplayback?expire=1746388521&ei=yXEXaM6RA5aahcIPiIKRuA4&ip=2.123.174.250&id=o-AHr1odxj7taZ78URdVW23qWnneENb4o91B_70f6XvJ9X&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1746366921%2C&mh=4m&mm=31%2C29&mn=sn-cn3tc-cimd%2Csn-aigl6nze&ms=au%2Crdu&mv=m&mvi=3&pl=22&rms=au%2Cau&initcwndbps=2796250&siu=1&bui=AecWEAbO9gybI2nt7by3tNpTHTOWWNZulld4J3GykZUgKyfCWGTBilDf-6cHfqCxIk-Fwzlv0Q&spc=wk1kZmwpL6C5&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=Qh3HHM48DzrWWlqVXEkTbGoQ&rqh=1&gir=yes&clen=26398728&dur=1649.461&lmt=1740168502863610&mt=1746366577&fvip=2&keepalive=yes&lmw=1&c=TVHTML5&sefc=1&txp=4432534&n=4YCXar7kqZli6Lge4g6EVP&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&sig=AJfQdSswRgIhAOjiU4RAB50eVvM9jkb50_p5SzBfWuZLKm0-B1gj0pD1AiEA6TcUWTQidym8UUC9xubUdu7_iPzWDPd-W5R2wzWroGo%3D&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=ACu; got HTTP status 403 May 04 14:55:21 volumio volumio[1089]: MPDError: Failed to decode https://rr3---sn-cn3tc-cimd.googlevideo.com/videoplayback?expire=1746388521&ei=yXEXaM6RA5aahcIPiIKRuA4&ip=2.123.174.250&id=o-AHr1odxj7taZ78URdVW23qWnneENb4o91B_70f6XvJ9X&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1746366921%2C&mh=4m&mm=31%2C29&mn=sn-cn3tc-cimd%2Csn-aigl6nze&ms=au%2Crdu&mv=m&mvi=3&pl=22&rms=au%2Cau&initcwndbps=2796250&siu=1&bui=AecWEAbO9gybI2nt7by3tNpTHTOWWNZulld4J3GykZUgKyfCWGTBilDf-6cHfqCxIk-Fwzlv0Q&spc=wk1kZmwpL6C5&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=Qh3HHM48DzrWWlqVXEkTbGoQ&rqh=1&gir=yes&clen=26398728&dur=1649.461&lmt=1740168502863610&mt=1746366577&fvip=2&keepalive=yes&lmw=1&c=TVHTML5&sefc=1&txp=4432534&n=4YCXar7kqZli6Lge4g6EVP&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&sig=AJfQdSswRgIhAOjiU4RAB50eVvM9jkb50_p5SzBfWuZLKm0-B1gj0pD1AiEA6TcUWTQidym8UUC9xubUdu7_iPzWDPd-W5R2wzWroGo%3D&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=ACu; got HTTP status 403 May 04 14:55:21 volumio volumio[1089]: at MPDClient._receive (/data/plugins/music_service/ytcr/node_modules/mpd2/lib/index.js:147:24) May 04 14:55:21 volumio volumio[1089]: at Socket.emit (events.js:315:20) May 04 14:55:21 volumio volumio[1089]: at addChunk (internal/streams/readable.js:309:12) May 04 14:55:21 volumio volumio[1089]: at readableAddChunk (internal/streams/readable.js:280:11) May 04 14:55:21 volumio volumio[1089]: at Socket.Readable.push (internal/streams/readable.js:223:10) May 04 14:55:21 volumio volumio[1089]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) May 04 14:55:21 volumio volumio[1089]: info: Ignoring MPD Status Update May 04 14:55:21 volumio volumio[1089]: info: Ignoring MPD Status Update May 04 14:55:21 volumio volumio[1089]: info: Ignoring MPD Status Update May 04 14:55:21 volumio volumio[1089]: info: Ignoring MPD Status Update May 04 14:55:21 volumio volumio[1089]: info: Ignoring MPD Status Update May 04 14:55:21 volumio volumio[1089]: info: Ignoring MPD Status Update May 04 14:55:21 volumio volumio[1089]: info: Ignoring MPD Status Update May 04 14:55:21 volumio volumio[1089]: info: Ignoring MPD Status Update May 04 14:55:21 volumio volumio[1089]: info: Ignoring MPD Status Update May 04 14:55:21 volumio volumio[1089]: info: Ignoring MPD Status Update May 04 14:55:21 volumio volumio[1089]: error: [ytcr] MPD error: May 04 14:55:21 volumio volumio[1089]: (MPDError) Failed to decode https://rr3---sn-cn3tc-cimd.googlevideo.com/videoplayback?expire=1746388521&ei=yXEXaKXvCtKZhcIPq8SH8Qc&ip=2.123.174.250&id=o-AGvr_G8equESPqRWNVBrvqrHIXTNhyHs_-tDc1-6zOJt&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1746366921%2C&mh=4m&mm=31%2C29&mn=sn-cn3tc-cimd%2Csn-aigl6nze&ms=au%2Crdu&mv=m&mvi=3&pl=22&rms=au%2Cau&initcwndbps=2796250&siu=1&bui=AecWEAbLlFdfpEfmSYyJuPCJ_M9UyRiL9j77UCGoTEWtv0amkIHSgtK1djskKcMr8e-9yh0Cxg&spc=wk1kZo2z4MHE&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=aYq2nHropACih0fLzjnWUigQ&rqh=1&gir=yes&clen=26398728&dur=1649.461&lmt=1740168502863610&mt=1746366577&fvip=2&keepalive=yes&lmw=1&c=TVHTML5&sefc=1&txp=4432534&n=SsiEWiTXEwGvWjXAE4ZXjZ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&sig=AJfQdSswRQIhAIoFiIyEbRlXX7iO3CzN_VS_ctqYxKSGxlfVdRQDe_nnAiBCkGquAplWxZIZ49wPnxll5SAKsvNIGwRatuIJPZG09g%3D%3D&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=A; got HTTP status 403 May 04 14:55:21 volumio volumio[1089]: MPDError: Failed to decode https://rr3---sn-cn3tc-cimd.googlevideo.com/videoplayback?expire=1746388521&ei=yXEXaKXvCtKZhcIPq8SH8Qc&ip=2.123.174.250&id=o-AGvr_G8equESPqRWNVBrvqrHIXTNhyHs_-tDc1-6zOJt&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1746366921%2C&mh=4m&mm=31%2C29&mn=sn-cn3tc-cimd%2Csn-aigl6nze&ms=au%2Crdu&mv=m&mvi=3&pl=22&rms=au%2Cau&initcwndbps=2796250&siu=1&bui=AecWEAbLlFdfpEfmSYyJuPCJ_M9UyRiL9j77UCGoTEWtv0amkIHSgtK1djskKcMr8e-9yh0Cxg&spc=wk1kZo2z4MHE&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=aYq2nHropACih0fLzjnWUigQ&rqh=1&gir=yes&clen=26398728&dur=1649.461&lmt=1740168502863610&mt=1746366577&fvip=2&keepalive=yes&lmw=1&c=TVHTML5&sefc=1&txp=4432534&n=SsiEWiTXEwGvWjXAE4ZXjZ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&sig=AJfQdSswRQIhAIoFiIyEbRlXX7iO3CzN_VS_ctqYxKSGxlfVdRQDe_nnAiBCkGquAplWxZIZ49wPnxll5SAKsvNIGwRatuIJPZG09g%3D%3D&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=A; got HTTP status 403 May 04 14:55:21 volumio volumio[1089]: at MPDClient._receive (/data/plugins/music_service/ytcr/node_modules/mpd2/lib/index.js:147:24) May 04 14:55:21 volumio volumio[1089]: at Socket.emit (events.js:315:20) May 04 14:55:21 volumio volumio[1089]: at addChunk (internal/streams/readable.js:309:12) May 04 14:55:21 volumio volumio[1089]: at readableAddChunk (internal/streams/readable.js:280:11) May 04 14:55:21 volumio volumio[1089]: at Socket.Readable.push (internal/streams/readable.js:223:10) May 04 14:55:21 volumio volumio[1089]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) May 04 14:55:21 volumio volumio[1089]: info: Ignoring MPD Status Update May 04 14:55:21 volumio volumio[1089]: info: Ignoring MPD Status Update May 04 14:55:21 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:55:21 volumio volumio[1089]: info: CoreCommandRouter::servicePushState May 04 14:55:21 volumio volumio[1089]: info: CoreStateMachine::pushState May 04 14:55:21 volumio volumio[1089]: info: CoreCommandRouter::volumioPushState May 04 14:55:22 volumio volumio[1089]: info: CoreCommandRouter::volumioVolatilePlay May 04 14:55:22 volumio volumio[1089]: info: CoreStateMachine::volatilePlay May 04 14:55:22 volumio volumio[1089]: info: [yt-cast-receiver] Player.resume() May 04 14:55:22 volumio volumio[1089]: info: [yt-cast-receiver] Player.play(): Lm2z1JEKx2U @ 0s May 04 14:55:22 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:55:22 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:55:23 volumio volumio[1089]: info: Ignoring MPD Status Update May 04 14:55:23 volumio volumio[1089]: info: Ignoring MPD Status Update May 04 14:55:23 volumio volumio[1089]: info: Ignoring MPD Status Update May 04 14:55:23 volumio volumio[1089]: info: Ignoring MPD Status Update May 04 14:55:23 volumio volumio[1089]: info: Ignoring MPD Status Update May 04 14:55:23 volumio volumio[1089]: info: Ignoring MPD Status Update May 04 14:55:23 volumio volumio[1089]: info: Ignoring MPD Status Update May 04 14:55:23 volumio volumio[1089]: info: Ignoring MPD Status Update May 04 14:55:23 volumio volumio[1089]: info: Ignoring MPD Status Update May 04 14:55:23 volumio volumio[1089]: info: Ignoring MPD Status Update May 04 14:55:23 volumio volumio[1089]: error: [ytcr] MPD error: May 04 14:55:23 volumio volumio[1089]: (MPDError) Failed to decode https://rr3---sn-cn3tc-cimd.googlevideo.com/videoplayback?expire=1746388522&ei=ynEXaI_vOonGp-oPu9-H0AE&ip=2.123.174.250&id=o-AKDbpPBX8UDPAW3fAmBOU_JmvfMBNhhQ--fQaIxOxUxy&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1746366922%2C&mh=4m&mm=31%2C29&mn=sn-cn3tc-cimd%2Csn-aigl6nze&ms=au%2Crdu&mv=m&mvi=3&pl=22&rms=au%2Cau&initcwndbps=2796250&siu=1&bui=AecWEAZ1Ajdqwie900rxvZM9zVNWOXJZTM6Rlfwjf4ZWnN2xN4QvYlVtf3On7pPK84bniMTBlA&spc=wk1kZkFIvkXg&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=KXqHGM7ZGIpVIJQrSJly3JkQ&rqh=1&gir=yes&clen=26398728&dur=1649.461&lmt=1740168502863610&mt=1746366577&fvip=2&keepalive=yes&lmw=1&c=TVHTML5&sefc=1&txp=4432534&n=m3AI69gkDeChRU-weNkl_-&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&sig=AJfQdSswRgIhAKK66WvSaL4UrR5mgGGUDLV0a7OuONrkntR3-w5E1L5nAiEApr_XHVpXGnUHl4MT9EozNVqfUgt2efRVc842gMhHMTg%3D&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=ACu; got HTTP status 403 May 04 14:55:23 volumio volumio[1089]: MPDError: Failed to decode https://rr3---sn-cn3tc-cimd.googlevideo.com/videoplayback?expire=1746388522&ei=ynEXaI_vOonGp-oPu9-H0AE&ip=2.123.174.250&id=o-AKDbpPBX8UDPAW3fAmBOU_JmvfMBNhhQ--fQaIxOxUxy&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1746366922%2C&mh=4m&mm=31%2C29&mn=sn-cn3tc-cimd%2Csn-aigl6nze&ms=au%2Crdu&mv=m&mvi=3&pl=22&rms=au%2Cau&initcwndbps=2796250&siu=1&bui=AecWEAZ1Ajdqwie900rxvZM9zVNWOXJZTM6Rlfwjf4ZWnN2xN4QvYlVtf3On7pPK84bniMTBlA&spc=wk1kZkFIvkXg&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=KXqHGM7ZGIpVIJQrSJly3JkQ&rqh=1&gir=yes&clen=26398728&dur=1649.461&lmt=1740168502863610&mt=1746366577&fvip=2&keepalive=yes&lmw=1&c=TVHTML5&sefc=1&txp=4432534&n=m3AI69gkDeChRU-weNkl_-&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&sig=AJfQdSswRgIhAKK66WvSaL4UrR5mgGGUDLV0a7OuONrkntR3-w5E1L5nAiEApr_XHVpXGnUHl4MT9EozNVqfUgt2efRVc842gMhHMTg%3D&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=ACu; got HTTP status 403 May 04 14:55:23 volumio volumio[1089]: at MPDClient._receive (/data/plugins/music_service/ytcr/node_modules/mpd2/lib/index.js:147:24) May 04 14:55:23 volumio volumio[1089]: at Socket.emit (events.js:315:20) May 04 14:55:23 volumio volumio[1089]: at addChunk (internal/streams/readable.js:309:12) May 04 14:55:23 volumio volumio[1089]: at readableAddChunk (internal/streams/readable.js:280:11) May 04 14:55:23 volumio volumio[1089]: at Socket.Readable.push (internal/streams/readable.js:223:10) May 04 14:55:23 volumio volumio[1089]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) May 04 14:55:23 volumio volumio[1089]: info: Ignoring MPD Status Update May 04 14:55:23 volumio volumio[1089]: info: Ignoring MPD Status Update May 04 14:55:23 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState May 04 14:55:23 volumio volumio[1089]: info: CoreCommandRouter::servicePushState May 04 14:55:23 volumio volumio[1089]: info: CoreStateMachine::pushState May 04 14:55:23 volumio volumio[1089]: info: CoreCommandRouter::volumioPushState May 04 14:55:31 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 04 14:55:31 volumio volumio[1089]: info: Preload queue cleared May 04 14:55:32 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 04 14:55:32 volumio volumio[1089]: info: Preload queue cleared May 04 14:55:33 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 04 14:55:33 volumio volumio[1089]: info: Preload queue cleared May 04 14:55:34 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 04 14:55:34 volumio volumio[1089]: info: Preload queue cleared May 04 14:55:34 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 04 14:55:34 volumio volumio[1089]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 04 14:55:34 volumio volumio[1089]: TypeError: Cannot read property 'length' of undefined May 04 14:55:34 volumio volumio[1089]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 May 04 14:55:34 volumio volumio[1089]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 May 04 14:55:34 volumio volumio[1089]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) May 04 14:55:34 volumio volumio[1089]: at Parser.emit (events.js:315:20) May 04 14:55:34 volumio volumio[1089]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) May 04 14:55:34 volumio volumio[1089]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) May 04 14:55:34 volumio volumio[1089]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) May 04 14:55:34 volumio volumio[1089]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) May 04 14:55:34 volumio volumio[1089]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) May 04 14:55:34 volumio volumio[1089]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) May 04 14:55:34 volumio volumio[1089]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) May 04 14:55:34 volumio volumio[1089]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) May 04 14:55:34 volumio volumio[1089]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) May 04 14:55:34 volumio volumio[1089]: at IncomingMessage.emit (events.js:327:22) May 04 14:55:34 volumio volumio[1089]: at endReadableNT (internal/streams/readable.js:1327:12) May 04 14:55:34 volumio volumio[1089]: at processTicksAndRejections (internal/process/task_queues.js:80:21) May 04 14:55:34 volumio volumio[1089]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 04 14:55:34 volumio sudo[5943]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-04 14:54 May 04 14:55:34 volumio sudo[5943]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="9ab87de061b3649c303da550e73c92d340b0f989" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 24 Apr 2025 09:33:57 AM CEST" VOLUMIO_VERSION="3.804" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="354f95cf0a6c2cbcd57b1aca3179c81c"