Oct 27 17:02:00 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 27 17:02:00 volumio volumio[1149]: info: Received Get System Info Oct 27 17:02:00 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 27 17:02:00 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 27 17:02:00 volumio volumio[1149]: info: Discovery: Getting this device information Oct 27 17:02:00 volumio volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 27 17:02:00 volumio volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 27 17:02:00 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 27 17:02:01 volumio systemd[1]: systemd-timedated.service: Deactivated successfully. Oct 27 17:02:02 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 27 17:02:08 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 27 17:02:08 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 27 17:02:10 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 27 17:02:10 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 27 17:02:10 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 27 17:02:10 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 27 17:02:10 volumio volumio[1149]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 15 Oct 27 17:02:10 volumio volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 27 17:02:10 volumio volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 27 17:02:11 volumio volumio-remote-updater[711]: Test mode disabled Oct 27 17:02:11 volumio volumio-remote-updater[711]: Alpha mode disabled Oct 27 17:02:11 volumio volumio-remote-updater[711]: Alpha legacy test mode disabled Oct 27 17:02:11 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Oct 27 17:02:11 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 27 17:02:11 volumio volumio[1149]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Oct 27 17:02:11 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Oct 27 17:02:11 volumio volumio[1149]: info: Received Get System Version Oct 27 17:02:11 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 27 17:02:11 volumio volumio[1149]: info: Received Get System Info Oct 27 17:02:11 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 27 17:02:11 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 27 17:02:11 volumio volumio[1149]: info: Discovery: Getting this device information Oct 27 17:02:11 volumio volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 27 17:02:11 volumio volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 27 17:02:11 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 27 17:02:11 volumio volumio[1149]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Oct 27 17:02:11 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Oct 27 17:02:15 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 27 17:02:15 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 27 17:02:15 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Oct 27 17:02:15 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Oct 27 17:02:15 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Oct 27 17:02:15 volumio volumio[1149]: info: CoreCommandRouter::volumioGetBrowseSources Oct 27 17:02:15 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 27 17:02:17 volumio volumio[1149]: error: MyVolumio Plugin failed to authenticate in a timely fashion Oct 27 17:02:17 volumio volumio[1149]: info: Completed starting MyVolumio Plugin Oct 27 17:02:17 volumio volumio[1149]: [Metrics] CommandRouter: 43s 175.98ms Oct 27 17:02:17 volumio volumio[1149]: info: CoreCommandRouter::volumiosetStartupVolume Oct 27 17:02:17 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 27 17:02:17 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 27 17:02:17 volumio volumio[1149]: info: CoreCommandRouter::Close All Modals sent Oct 27 17:02:17 volumio volumio[1149]: info: CoreCommandRouter::Close All Modals sent Oct 27 17:02:18 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Oct 27 17:02:18 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 27 17:02:18 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Oct 27 17:02:23 volumio sudo[1593]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 27 17:02:23 volumio sudo[1593]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 27 17:02:23 volumio sudo[1593]: pam_unix(sudo:session): session closed for user root Oct 27 17:02:23 volumio sudo[1595]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 27 17:02:23 volumio sudo[1595]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 27 17:02:23 volumio sudo[1595]: pam_unix(sudo:session): session closed for user root Oct 27 17:02:23 volumio volumio[1149]: verbose: New Socket.io Connection to 192.168.10.115 from 192.168.10.112 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 16 Oct 27 17:02:23 volumio volumio[1149]: info: Received Get System Info Oct 27 17:02:23 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 27 17:02:23 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 27 17:02:23 volumio volumio[1149]: info: Discovery: Getting this device information Oct 27 17:02:23 volumio volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 27 17:02:23 volumio volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 27 17:02:23 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 27 17:02:23 volumio volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 27 17:02:23 volumio volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 27 17:02:23 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 27 17:02:23 volumio volumio[1149]: info: CoreCommandRouter::volumioGetVisibleSources Oct 27 17:02:23 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 27 17:02:23 volumio volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 27 17:02:23 volumio volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 27 17:02:23 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 27 17:02:23 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 27 17:02:23 volumio volumio[1149]: info: Received Get System Info Oct 27 17:02:23 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 27 17:02:23 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 27 17:02:23 volumio volumio[1149]: info: Discovery: Getting this device information Oct 27 17:02:23 volumio volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 27 17:02:23 volumio volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 27 17:02:23 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 27 17:02:23 volumio volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 27 17:02:23 volumio volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 27 17:02:23 volumio volumio[1149]: info: Listing playlists Oct 27 17:02:23 volumio volumio[1149]: info: Received Get System Info Oct 27 17:02:23 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 27 17:02:23 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 27 17:02:23 volumio volumio[1149]: info: Discovery: Getting this device information Oct 27 17:02:23 volumio volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 27 17:02:23 volumio volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 27 17:02:23 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 27 17:02:23 volumio volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 27 17:02:23 volumio volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 27 17:02:23 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 27 17:02:24 volumio volumio[1149]: info: CoreCommandRouter::volumioGetState Oct 27 17:02:24 volumio volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 27 17:02:24 volumio volumio[1149]: info: BOOT COMPLETED Oct 27 17:02:30 volumio volumio[1149]: info: CoreCommandRouter::volumioGetQueue Oct 27 17:02:30 volumio volumio[1149]: info: CoreStateMachine::getQueue Oct 27 17:02:30 volumio volumio[1149]: info: CorePlayQueue::getQueue Oct 27 17:02:33 volumio systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... Oct 27 17:02:33 volumio dbus-daemon[671]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.24' (uid=0 pid=1613 comm="timedatectl show --property=NTPSynchronized --valu") Oct 27 17:02:33 volumio systemd[1]: Starting systemd-timedated.service - Time & Date Service... Oct 27 17:02:33 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 27 17:02:33 volumio dbus-daemon[671]: [system] Successfully activated service 'org.freedesktop.timedate1' Oct 27 17:02:33 volumio systemd[1]: Started systemd-timedated.service - Time & Date Service. Oct 27 17:02:33 volumio setdatetime-helper.sh[1612]: Time is not synchronized. Attempting to sync... Oct 27 17:02:33 volumio sudo[1621]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/date -s 'Mon, 27 Oct 2025 08:02:33 GMT#015' Oct 27 17:02:33 volumio sudo[1621]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Oct 27 17:02:33 volumio setdatetime-helper.sh[1622]: Mon Oct 27 17:02:33 JST 2025 Oct 27 17:02:33 volumio setdatetime-helper.sh[1612]: Time synchronized successfully. Oct 27 17:02:33 volumio systemd-journald[352]: Time jumped backwards, rotating. Oct 27 17:02:33 volumio sudo[1621]: pam_unix(sudo:session): session closed for user root Oct 27 17:02:33 volumio systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. Oct 27 17:02:33 volumio systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. Oct 27 17:02:37 volumio volumio[1149]: info: Preload queue cleared Oct 27 17:02:37 volumio volumio[1149]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 27 17:02:37 volumio volumio[1149]: info: CoreStateMachine::ClearQueue Oct 27 17:02:37 volumio volumio[1149]: info: CoreStateMachine::stop Oct 27 17:02:37 volumio volumio[1149]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 17:02:37 volumio volumio[1149]: info: CorePlayQueue::clearPlayQueue Oct 27 17:02:37 volumio volumio[1149]: info: CorePlayQueue::saveQueue Oct 27 17:02:37 volumio volumio[1149]: info: CoreCommandRouter::volumioPushQueue Oct 27 17:02:37 volumio volumio[1149]: info: CoreStateMachine::addQueueItems Oct 27 17:02:37 volumio volumio[1149]: info: CorePlayQueue::addQueueItems Oct 27 17:02:37 volumio volumio[1149]: info: Preload queue cleared Oct 27 17:02:37 volumio volumio[1149]: info: Adding Item to queue: youtube2/generic@endpoint:o=%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22UC-9-kyTW8ZkZNDHQJ6FgpwQ%22%7D%7D/playlist@endpoints:o=%7B%22watch%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22playlistId%22%3A%22RDCLAK5uy_kb7EBi6y3GrtJri4_ZH56Ms786DFEimbM%22%7D%7D%7D Oct 27 17:02:37 volumio volumio[1149]: info: Exploding uri youtube2/generic@endpoint:o=%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22UC-9-kyTW8ZkZNDHQJ6FgpwQ%22%7D%7D/playlist@endpoints:o=%7B%22watch%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22playlistId%22%3A%22RDCLAK5uy_kb7EBi6y3GrtJri4_ZH56Ms786DFEimbM%22%7D%7D%7D in service youtube2 Oct 27 17:02:37 volumio volumio[1149]: info: CoreCommandRouter::volumioPushQueue Oct 27 17:02:37 volumio volumio[1149]: info: CorePlayQueue::saveQueue Oct 27 17:02:37 volumio volumio[1149]: info: CoreStateMachine::updateTrackBlock Oct 27 17:02:37 volumio volumio[1149]: info: CorePlayQueue::getTrackBlock Oct 27 17:02:37 volumio volumio[1149]: info: CoreCommandRouter::volumioPlay Oct 27 17:02:37 volumio volumio[1149]: info: CoreStateMachine::play index 0 Oct 27 17:02:37 volumio volumio[1149]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 17:02:37 volumio volumio[1149]: info: CoreStateMachine::stop Oct 27 17:02:37 volumio volumio[1149]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 17:02:37 volumio volumio[1149]: info: CoreStateMachine::play index undefined Oct 27 17:02:37 volumio volumio[1149]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 17:02:37 volumio volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 27 17:02:37 volumio volumio[1149]: info: CoreStateMachine::startPlaybackTimer Oct 27 17:02:37 volumio volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 27 17:02:41 volumio volumio[1149]: info: Preload queue cleared Oct 27 17:02:41 volumio volumio[1149]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 27 17:02:41 volumio volumio[1149]: info: CoreStateMachine::ClearQueue Oct 27 17:02:41 volumio volumio[1149]: info: CoreStateMachine::stop Oct 27 17:02:41 volumio volumio[1149]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 17:02:41 volumio volumio[1149]: info: CorePlayQueue::clearPlayQueue Oct 27 17:02:41 volumio volumio[1149]: info: CorePlayQueue::saveQueue Oct 27 17:02:41 volumio volumio[1149]: info: CoreCommandRouter::volumioPushQueue Oct 27 17:02:41 volumio volumio[1149]: info: CoreStateMachine::addQueueItems Oct 27 17:02:41 volumio volumio[1149]: info: CorePlayQueue::addQueueItems Oct 27 17:02:41 volumio volumio[1149]: info: Preload queue cleared Oct 27 17:02:41 volumio volumio[1149]: info: Adding Item to queue: youtube2/generic@endpoint:o=%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22UC-9-kyTW8ZkZNDHQJ6FgpwQ%22%7D%7D/playlist@endpoints:o=%7B%22watch%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22playlistId%22%3A%22RDCLAK5uy_kb7EBi6y3GrtJri4_ZH56Ms786DFEimbM%22%7D%7D%7D Oct 27 17:02:41 volumio volumio[1149]: info: Exploding uri youtube2/generic@endpoint:o=%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22UC-9-kyTW8ZkZNDHQJ6FgpwQ%22%7D%7D/playlist@endpoints:o=%7B%22watch%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22playlistId%22%3A%22RDCLAK5uy_kb7EBi6y3GrtJri4_ZH56Ms786DFEimbM%22%7D%7D%7D in service youtube2 Oct 27 17:02:41 volumio volumio[1149]: info: CoreCommandRouter::volumioPushQueue Oct 27 17:02:41 volumio volumio[1149]: info: CorePlayQueue::saveQueue Oct 27 17:02:41 volumio volumio[1149]: info: CoreStateMachine::updateTrackBlock Oct 27 17:02:41 volumio volumio[1149]: info: CorePlayQueue::getTrackBlock Oct 27 17:02:41 volumio volumio[1149]: info: CoreCommandRouter::volumioPlay Oct 27 17:02:41 volumio volumio[1149]: info: CoreStateMachine::play index 0 Oct 27 17:02:41 volumio volumio[1149]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 17:02:41 volumio volumio[1149]: info: CoreStateMachine::stop Oct 27 17:02:41 volumio volumio[1149]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 17:02:41 volumio volumio[1149]: info: CoreStateMachine::play index undefined Oct 27 17:02:41 volumio volumio[1149]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 17:02:41 volumio volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 27 17:02:41 volumio volumio[1149]: info: CoreStateMachine::startPlaybackTimer Oct 27 17:02:41 volumio volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 27 17:02:43 volumio volumio[1149]: info: Preload queue cleared Oct 27 17:02:43 volumio volumio[1149]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 27 17:02:43 volumio volumio[1149]: info: CoreStateMachine::ClearQueue Oct 27 17:02:43 volumio volumio[1149]: info: CoreStateMachine::stop Oct 27 17:02:43 volumio volumio[1149]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 17:02:43 volumio volumio[1149]: info: CorePlayQueue::clearPlayQueue Oct 27 17:02:43 volumio volumio[1149]: info: CorePlayQueue::saveQueue Oct 27 17:02:43 volumio volumio[1149]: info: CoreCommandRouter::volumioPushQueue Oct 27 17:02:43 volumio volumio[1149]: info: CoreStateMachine::addQueueItems Oct 27 17:02:43 volumio volumio[1149]: info: CorePlayQueue::addQueueItems Oct 27 17:02:43 volumio volumio[1149]: info: Preload queue cleared Oct 27 17:02:43 volumio volumio[1149]: info: Adding Item to queue: youtube2/generic@endpoint:o=%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22UC-9-kyTW8ZkZNDHQJ6FgpwQ%22%7D%7D/playlist@endpoints:o=%7B%22watch%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22playlistId%22%3A%22RDCLAK5uy_kDTLUEleq2B4vQB6JB5P1DApC4nRayHUs%22%7D%7D%7D Oct 27 17:02:43 volumio volumio[1149]: info: Exploding uri youtube2/generic@endpoint:o=%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22UC-9-kyTW8ZkZNDHQJ6FgpwQ%22%7D%7D/playlist@endpoints:o=%7B%22watch%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22playlistId%22%3A%22RDCLAK5uy_kDTLUEleq2B4vQB6JB5P1DApC4nRayHUs%22%7D%7D%7D in service youtube2 Oct 27 17:02:43 volumio volumio[1149]: info: CoreCommandRouter::volumioPushQueue Oct 27 17:02:43 volumio volumio[1149]: info: CorePlayQueue::saveQueue Oct 27 17:02:43 volumio volumio[1149]: info: CoreStateMachine::updateTrackBlock Oct 27 17:02:43 volumio volumio[1149]: info: CorePlayQueue::getTrackBlock Oct 27 17:02:43 volumio volumio[1149]: info: CoreCommandRouter::volumioPlay Oct 27 17:02:43 volumio volumio[1149]: info: CoreStateMachine::play index 0 Oct 27 17:02:43 volumio volumio[1149]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 17:02:43 volumio volumio[1149]: info: CoreStateMachine::stop Oct 27 17:02:43 volumio volumio[1149]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 17:02:43 volumio volumio[1149]: info: CoreStateMachine::play index undefined Oct 27 17:02:43 volumio volumio[1149]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 17:02:43 volumio volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 27 17:02:43 volumio volumio[1149]: info: CoreStateMachine::startPlaybackTimer Oct 27 17:02:43 volumio volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 27 17:02:44 volumio volumio[1149]: info: Preload queue cleared Oct 27 17:02:44 volumio volumio[1149]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 27 17:02:44 volumio volumio[1149]: info: CoreStateMachine::ClearQueue Oct 27 17:02:44 volumio volumio[1149]: info: CoreStateMachine::stop Oct 27 17:02:44 volumio volumio[1149]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 17:02:44 volumio volumio[1149]: info: CorePlayQueue::clearPlayQueue Oct 27 17:02:44 volumio volumio[1149]: info: CorePlayQueue::saveQueue Oct 27 17:02:44 volumio volumio[1149]: info: CoreCommandRouter::volumioPushQueue Oct 27 17:02:44 volumio volumio[1149]: info: CoreStateMachine::addQueueItems Oct 27 17:02:44 volumio volumio[1149]: info: CorePlayQueue::addQueueItems Oct 27 17:02:44 volumio volumio[1149]: info: Preload queue cleared Oct 27 17:02:44 volumio volumio[1149]: info: Adding Item to queue: youtube2/generic@endpoint:o=%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22UC-9-kyTW8ZkZNDHQJ6FgpwQ%22%7D%7D/playlist@endpoints:o=%7B%22watch%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22playlistId%22%3A%22RDCLAK5uy_kCiC2hty_MCamSRVBdl1Bhcu-vRWxPBJw%22%7D%7D%7D Oct 27 17:02:44 volumio volumio[1149]: info: Exploding uri youtube2/generic@endpoint:o=%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22UC-9-kyTW8ZkZNDHQJ6FgpwQ%22%7D%7D/playlist@endpoints:o=%7B%22watch%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22playlistId%22%3A%22RDCLAK5uy_kCiC2hty_MCamSRVBdl1Bhcu-vRWxPBJw%22%7D%7D%7D in service youtube2 Oct 27 17:02:44 volumio volumio[1149]: info: CoreCommandRouter::volumioPushQueue Oct 27 17:02:44 volumio volumio[1149]: info: CorePlayQueue::saveQueue Oct 27 17:02:44 volumio volumio[1149]: info: CoreStateMachine::updateTrackBlock Oct 27 17:02:44 volumio volumio[1149]: info: CorePlayQueue::getTrackBlock Oct 27 17:02:44 volumio volumio[1149]: info: CoreCommandRouter::volumioPlay Oct 27 17:02:44 volumio volumio[1149]: info: CoreStateMachine::play index 0 Oct 27 17:02:44 volumio volumio[1149]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 17:02:44 volumio volumio[1149]: info: CoreStateMachine::stop Oct 27 17:02:44 volumio volumio[1149]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 17:02:44 volumio volumio[1149]: info: CoreStateMachine::play index undefined Oct 27 17:02:44 volumio volumio[1149]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 17:02:44 volumio volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 27 17:02:44 volumio volumio[1149]: info: CoreStateMachine::startPlaybackTimer Oct 27 17:02:44 volumio volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 27 17:02:45 volumio volumio[1149]: info: Preload queue cleared Oct 27 17:02:45 volumio volumio[1149]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 27 17:02:45 volumio volumio[1149]: info: CoreStateMachine::ClearQueue Oct 27 17:02:45 volumio volumio[1149]: info: CoreStateMachine::stop Oct 27 17:02:45 volumio volumio[1149]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 17:02:45 volumio volumio[1149]: info: CorePlayQueue::clearPlayQueue Oct 27 17:02:45 volumio volumio[1149]: info: CorePlayQueue::saveQueue Oct 27 17:02:45 volumio volumio[1149]: info: CoreCommandRouter::volumioPushQueue Oct 27 17:02:45 volumio volumio[1149]: info: CoreStateMachine::addQueueItems Oct 27 17:02:45 volumio volumio[1149]: info: CorePlayQueue::addQueueItems Oct 27 17:02:45 volumio volumio[1149]: info: Preload queue cleared Oct 27 17:02:45 volumio volumio[1149]: info: Adding Item to queue: youtube2/generic@endpoint:o=%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22UC-9-kyTW8ZkZNDHQJ6FgpwQ%22%7D%7D/playlist@endpoints:o=%7B%22watch%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22playlistId%22%3A%22RDCLAK5uy_kjp6zyHpOx8iOCNf3PsYthXDWTY8ZtlW0%22%7D%7D%7D Oct 27 17:02:45 volumio volumio[1149]: info: Exploding uri youtube2/generic@endpoint:o=%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22UC-9-kyTW8ZkZNDHQJ6FgpwQ%22%7D%7D/playlist@endpoints:o=%7B%22watch%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22playlistId%22%3A%22RDCLAK5uy_kjp6zyHpOx8iOCNf3PsYthXDWTY8ZtlW0%22%7D%7D%7D in service youtube2 Oct 27 17:02:45 volumio volumio[1149]: info: CoreCommandRouter::volumioPushQueue Oct 27 17:02:45 volumio volumio[1149]: info: CorePlayQueue::saveQueue Oct 27 17:02:45 volumio volumio[1149]: info: CoreStateMachine::updateTrackBlock Oct 27 17:02:45 volumio volumio[1149]: info: CorePlayQueue::getTrackBlock Oct 27 17:02:45 volumio volumio[1149]: info: CoreCommandRouter::volumioPlay Oct 27 17:02:45 volumio volumio[1149]: info: CoreStateMachine::play index 0 Oct 27 17:02:45 volumio volumio[1149]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 17:02:45 volumio volumio[1149]: info: CoreStateMachine::stop Oct 27 17:02:45 volumio volumio[1149]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 17:02:45 volumio volumio[1149]: info: CoreStateMachine::play index undefined Oct 27 17:02:45 volumio volumio[1149]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 17:02:45 volumio volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 27 17:02:45 volumio volumio[1149]: info: CoreStateMachine::startPlaybackTimer Oct 27 17:02:45 volumio volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 27 17:02:46 volumio volumio[1149]: info: Preload queue cleared Oct 27 17:02:46 volumio volumio[1149]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 27 17:02:46 volumio volumio[1149]: info: CoreStateMachine::ClearQueue Oct 27 17:02:46 volumio volumio[1149]: info: CoreStateMachine::stop Oct 27 17:02:46 volumio volumio[1149]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 17:02:46 volumio volumio[1149]: info: CorePlayQueue::clearPlayQueue Oct 27 17:02:46 volumio volumio[1149]: info: CorePlayQueue::saveQueue Oct 27 17:02:46 volumio volumio[1149]: info: CoreCommandRouter::volumioPushQueue Oct 27 17:02:46 volumio volumio[1149]: info: CoreStateMachine::addQueueItems Oct 27 17:02:46 volumio volumio[1149]: info: CorePlayQueue::addQueueItems Oct 27 17:02:46 volumio volumio[1149]: info: Preload queue cleared Oct 27 17:02:46 volumio volumio[1149]: info: Adding Item to queue: youtube2/generic@endpoint:o=%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22UC-9-kyTW8ZkZNDHQJ6FgpwQ%22%7D%7D/playlist@endpoints:o=%7B%22watch%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22playlistId%22%3A%22RDCLAK5uy_kjp6zyHpOx8iOCNf3PsYthXDWTY8ZtlW0%22%7D%7D%7D Oct 27 17:02:46 volumio volumio[1149]: info: Exploding uri youtube2/generic@endpoint:o=%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22UC-9-kyTW8ZkZNDHQJ6FgpwQ%22%7D%7D/playlist@endpoints:o=%7B%22watch%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22playlistId%22%3A%22RDCLAK5uy_kjp6zyHpOx8iOCNf3PsYthXDWTY8ZtlW0%22%7D%7D%7D in service youtube2 Oct 27 17:02:46 volumio volumio[1149]: info: CoreCommandRouter::volumioPushQueue Oct 27 17:02:46 volumio volumio[1149]: info: CorePlayQueue::saveQueue Oct 27 17:02:46 volumio volumio[1149]: info: CoreStateMachine::updateTrackBlock Oct 27 17:02:46 volumio volumio[1149]: info: CorePlayQueue::getTrackBlock Oct 27 17:02:46 volumio volumio[1149]: info: CoreCommandRouter::volumioPlay Oct 27 17:02:46 volumio volumio[1149]: info: CoreStateMachine::play index 0 Oct 27 17:02:46 volumio volumio[1149]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 17:02:46 volumio volumio[1149]: info: CoreStateMachine::stop Oct 27 17:02:46 volumio volumio[1149]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 17:02:46 volumio volumio[1149]: info: CoreStateMachine::play index undefined Oct 27 17:02:46 volumio volumio[1149]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 17:02:46 volumio volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 27 17:02:46 volumio volumio[1149]: info: CoreStateMachine::startPlaybackTimer Oct 27 17:02:46 volumio volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 27 17:02:47 volumio volumio[1149]: info: Preload queue cleared Oct 27 17:02:47 volumio volumio[1149]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 27 17:02:47 volumio volumio[1149]: info: CoreStateMachine::ClearQueue Oct 27 17:02:47 volumio volumio[1149]: info: CoreStateMachine::stop Oct 27 17:02:47 volumio volumio[1149]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 17:02:47 volumio volumio[1149]: info: CorePlayQueue::clearPlayQueue Oct 27 17:02:47 volumio volumio[1149]: info: CorePlayQueue::saveQueue Oct 27 17:02:47 volumio volumio[1149]: info: CoreCommandRouter::volumioPushQueue Oct 27 17:02:47 volumio volumio[1149]: info: CoreStateMachine::addQueueItems Oct 27 17:02:47 volumio volumio[1149]: info: CorePlayQueue::addQueueItems Oct 27 17:02:47 volumio volumio[1149]: info: Preload queue cleared Oct 27 17:02:47 volumio volumio[1149]: info: Adding Item to queue: youtube2/generic@endpoint:o=%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22UC-9-kyTW8ZkZNDHQJ6FgpwQ%22%7D%7D/playlist@endpoints:o=%7B%22watch%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22playlistId%22%3A%22RDCLAK5uy_kjp6zyHpOx8iOCNf3PsYthXDWTY8ZtlW0%22%7D%7D%7D Oct 27 17:02:47 volumio volumio[1149]: info: Exploding uri youtube2/generic@endpoint:o=%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22UC-9-kyTW8ZkZNDHQJ6FgpwQ%22%7D%7D/playlist@endpoints:o=%7B%22watch%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22playlistId%22%3A%22RDCLAK5uy_kjp6zyHpOx8iOCNf3PsYthXDWTY8ZtlW0%22%7D%7D%7D in service youtube2 Oct 27 17:02:47 volumio volumio[1149]: info: CoreCommandRouter::volumioPushQueue Oct 27 17:02:47 volumio volumio[1149]: info: CorePlayQueue::saveQueue Oct 27 17:02:47 volumio volumio[1149]: info: CoreStateMachine::updateTrackBlock Oct 27 17:02:47 volumio volumio[1149]: info: CorePlayQueue::getTrackBlock Oct 27 17:02:47 volumio volumio[1149]: info: CoreCommandRouter::volumioPlay Oct 27 17:02:47 volumio volumio[1149]: info: CoreStateMachine::play index 0 Oct 27 17:02:47 volumio volumio[1149]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 17:02:47 volumio volumio[1149]: info: CoreStateMachine::stop Oct 27 17:02:47 volumio volumio[1149]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 17:02:47 volumio volumio[1149]: info: CoreStateMachine::play index undefined Oct 27 17:02:47 volumio volumio[1149]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 17:02:47 volumio volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 27 17:02:47 volumio volumio[1149]: info: CoreStateMachine::startPlaybackTimer Oct 27 17:02:47 volumio volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 27 17:02:47 volumio volumio[1149]: info: Preload queue cleared Oct 27 17:02:47 volumio volumio[1149]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 27 17:02:47 volumio volumio[1149]: info: CoreStateMachine::ClearQueue Oct 27 17:02:47 volumio volumio[1149]: info: CoreStateMachine::stop Oct 27 17:02:47 volumio volumio[1149]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 17:02:47 volumio volumio[1149]: info: CorePlayQueue::clearPlayQueue Oct 27 17:02:47 volumio volumio[1149]: info: CorePlayQueue::saveQueue Oct 27 17:02:47 volumio volumio[1149]: info: CoreCommandRouter::volumioPushQueue Oct 27 17:02:47 volumio volumio[1149]: info: CoreStateMachine::addQueueItems Oct 27 17:02:47 volumio volumio[1149]: info: CorePlayQueue::addQueueItems Oct 27 17:02:47 volumio volumio[1149]: info: Preload queue cleared Oct 27 17:02:47 volumio volumio[1149]: info: Adding Item to queue: youtube2/generic@endpoint:o=%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22UC-9-kyTW8ZkZNDHQJ6FgpwQ%22%7D%7D/playlist@endpoints:o=%7B%22watch%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22playlistId%22%3A%22RDCLAK5uy_kjp6zyHpOx8iOCNf3PsYthXDWTY8ZtlW0%22%7D%7D%7D Oct 27 17:02:47 volumio volumio[1149]: info: Exploding uri youtube2/generic@endpoint:o=%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22UC-9-kyTW8ZkZNDHQJ6FgpwQ%22%7D%7D/playlist@endpoints:o=%7B%22watch%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22playlistId%22%3A%22RDCLAK5uy_kjp6zyHpOx8iOCNf3PsYthXDWTY8ZtlW0%22%7D%7D%7D in service youtube2 Oct 27 17:02:47 volumio volumio[1149]: info: CoreCommandRouter::volumioPushQueue Oct 27 17:02:47 volumio volumio[1149]: info: CorePlayQueue::saveQueue Oct 27 17:02:47 volumio volumio[1149]: info: CoreStateMachine::updateTrackBlock Oct 27 17:02:47 volumio volumio[1149]: info: CorePlayQueue::getTrackBlock Oct 27 17:02:47 volumio volumio[1149]: info: CoreCommandRouter::volumioPlay Oct 27 17:02:47 volumio volumio[1149]: info: CoreStateMachine::play index 0 Oct 27 17:02:47 volumio volumio[1149]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 17:02:47 volumio volumio[1149]: info: CoreStateMachine::stop Oct 27 17:02:47 volumio volumio[1149]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 17:02:47 volumio volumio[1149]: info: CoreStateMachine::play index undefined Oct 27 17:02:47 volumio volumio[1149]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 17:02:47 volumio volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 27 17:02:47 volumio volumio[1149]: info: CoreStateMachine::startPlaybackTimer Oct 27 17:02:47 volumio volumio[1149]: info: CorePlayQueue::getTrack 0 Oct 27 17:03:01 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Oct 27 17:03:01 volumio volumio[1149]: info: Preload queue cleared Oct 27 17:03:02 volumio systemd[1]: systemd-timedated.service: Deactivated successfully. Oct 27 17:03:05 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Oct 27 17:03:05 volumio volumio[1149]: info: Preload queue cleared Oct 27 17:03:10 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Oct 27 17:03:10 volumio volumio[1149]: Use XMLElement.setAttribute instead Oct 27 17:03:10 volumio volumio[1149]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 27 17:03:10 volumio volumio[1149]: TypeError: children[i].attr(...).value is not a function Oct 27 17:03:10 volumio volumio[1149]: at /volumio/app/plugins/music_service/webradio/index.js:428:46 Oct 27 17:03:10 volumio volumio[1149]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Oct 27 17:03:10 volumio volumio[1149]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 27 17:03:12 volumio sudo[1696]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-10-27 17:02' Oct 27 17:03:12 volumio sudo[1696]: 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="4a70cb031e64a8e498efc3e29470650871ff7d54" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat May 31 04:09:10 UTC 2025" VOLUMIO_VERSION="4.005" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="f9bd4447a30d4b2c74b3880e7a50e48b"