-- Logs begin at Thu 2025-10-16 23:29:23 +07, end at Thu 2025-10-16 23:31:49 +07. -- Oct 16 23:30:00 volumio volumio[1332]: info: Updating MyVolumio device info Oct 16 23:30:00 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 23:30:00 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 23:30:00 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 23:30:00 volumio volumio[1332]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Oct 16 23:30:06 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 16 23:30:06 volumio volumio[1332]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Oct 16 23:30:06 volumio volumio[1332]: info: CoreCommandRouter::volumioGetState Oct 16 23:30:06 volumio volumio[1332]: info: CorePlayQueue::getTrack 0 Oct 16 23:30:06 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 16 23:30:06 volumio volumio[1332]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Oct 16 23:30:06 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Oct 16 23:30:06 volumio volumio[1332]: info: Received Get System Version Oct 16 23:30:06 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 16 23:30:06 volumio volumio[1332]: info: Received Get System Info Oct 16 23:30:06 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 23:30:06 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 23:30:06 volumio volumio[1332]: info: Discovery: Getting this device information Oct 16 23:30:06 volumio volumio[1332]: info: CoreCommandRouter::volumioGetState Oct 16 23:30:06 volumio volumio[1332]: info: CorePlayQueue::getTrack 0 Oct 16 23:30:06 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 23:30:10 volumio systemd[1]: systemd-timedated.service: Succeeded. Oct 16 23:30:11 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 23:30:11 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Oct 16 23:30:11 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Oct 16 23:30:11 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Oct 16 23:30:11 volumio volumio[1332]: info: CoreCommandRouter::volumioGetBrowseSources Oct 16 23:30:11 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 16 23:30:11 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 16 23:30:11 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 23:30:11 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 16 23:30:11 volumio volumio[1332]: error: MyVolumio Plugin failed to authenticate in a timely fashion Oct 16 23:30:11 volumio volumio[1332]: info: Completed starting MyVolumio Plugin Oct 16 23:30:11 volumio volumio[1332]: [Metrics] CommandRouter: 32s 447.91ms Oct 16 23:30:11 volumio volumio[1332]: info: CoreCommandRouter::volumiosetStartupVolume Oct 16 23:30:11 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 23:30:11 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 23:30:11 volumio volumio[1332]: info: CoreCommandRouter::Close All Modals sent Oct 16 23:30:11 volumio volumio[1332]: info: CoreCommandRouter::Close All Modals sent Oct 16 23:30:11 volumio volumio-remote-updater[794]: No test mode Oct 16 23:30:11 volumio volumio-remote-updater[794]: No alpha test mode Oct 16 23:30:11 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Oct 16 23:30:12 volumio volumio[1332]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Oct 16 23:30:12 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Oct 16 23:30:12 volumio sudo[2126]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 16 23:30:12 volumio sudo[2126]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 23:30:12 volumio sudo[2126]: pam_unix(sudo:session): session closed for user root Oct 16 23:30:12 volumio sudo[2129]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 16 23:30:12 volumio sudo[2129]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 23:30:12 volumio sudo[2129]: pam_unix(sudo:session): session closed for user root Oct 16 23:30:12 volumio volumio[1332]: verbose: New Socket.io Connection to 192.168.88.113 from 192.168.88.108 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Edg/141.0.0.0 Engine version: 3 Transport: polling Total Clients: 9 Oct 16 23:30:12 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Oct 16 23:30:12 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 16 23:30:12 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Oct 16 23:30:12 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 16 23:30:12 volumio volumio[1332]: info: CoreCommandRouter::volumioGetVisibleSources Oct 16 23:30:12 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 23:30:12 volumio volumio[1332]: info: CoreCommandRouter::volumioGetState Oct 16 23:30:12 volumio volumio[1332]: info: CorePlayQueue::getTrack 0 Oct 16 23:30:12 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 16 23:30:12 volumio volumio[1332]: info: CoreCommandRouter::volumioGetQueue Oct 16 23:30:12 volumio volumio[1332]: info: CoreStateMachine::getQueue Oct 16 23:30:12 volumio volumio[1332]: info: CorePlayQueue::getQueue Oct 16 23:30:12 volumio volumio[1332]: info: Listing playlists Oct 16 23:30:12 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 16 23:30:12 volumio volumio[1332]: info: Received Get System Info Oct 16 23:30:12 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 23:30:12 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 23:30:12 volumio volumio[1332]: info: Discovery: Getting this device information Oct 16 23:30:12 volumio volumio[1332]: info: CoreCommandRouter::volumioGetState Oct 16 23:30:12 volumio volumio[1332]: info: CorePlayQueue::getTrack 0 Oct 16 23:30:12 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 23:30:12 volumio volumio[1332]: info: CoreCommandRouter::volumioGetState Oct 16 23:30:12 volumio volumio[1332]: info: CorePlayQueue::getTrack 0 Oct 16 23:30:12 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 16 23:30:12 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 16 23:30:12 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 16 23:30:14 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Oct 16 23:30:14 volumio go-librespot[1571]: time="2025-10-16T23:30:14+07:00" level=trace msg="sent dealer ping" Oct 16 23:30:14 volumio go-librespot[1571]: time="2025-10-16T23:30:14+07:00" level=trace msg="received dealer pong" Oct 16 23:30:14 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 16 23:30:14 volumio volumio[1332]: info: Received Get System Info Oct 16 23:30:14 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 23:30:14 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 23:30:14 volumio volumio[1332]: info: Discovery: Getting this device information Oct 16 23:30:14 volumio volumio[1332]: info: CoreCommandRouter::volumioGetState Oct 16 23:30:14 volumio volumio[1332]: info: CorePlayQueue::getTrack 0 Oct 16 23:30:14 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 23:30:15 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 16 23:30:15 volumio volumio[1332]: info: Received Get System Info Oct 16 23:30:15 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 23:30:15 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 23:30:15 volumio volumio[1332]: info: Discovery: Getting this device information Oct 16 23:30:15 volumio volumio[1332]: info: CoreCommandRouter::volumioGetState Oct 16 23:30:15 volumio volumio[1332]: info: CorePlayQueue::getTrack 0 Oct 16 23:30:15 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 23:30:17 volumio volumio[1332]: info: CoreCommandRouter::volumioGetState Oct 16 23:30:17 volumio volumio[1332]: info: CorePlayQueue::getTrack 0 Oct 16 23:30:18 volumio volumio[1332]: info: BOOT COMPLETED Oct 16 23:30:21 volumio volumio[1332]: verbose: New Socket.io Connection to 192.168.88.113 from 192.168.88.108 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Edg/141.0.0.0 Engine version: 3 Transport: polling Total Clients: 9 Oct 16 23:30:21 volumio volumio[1332]: info: CoreCommandRouter::volumioGetState Oct 16 23:30:21 volumio volumio[1332]: info: CorePlayQueue::getTrack 0 Oct 16 23:30:21 volumio volumio[1332]: info: Received Get System Info Oct 16 23:30:21 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 23:30:21 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 23:30:21 volumio volumio[1332]: info: Discovery: Getting this device information Oct 16 23:30:21 volumio volumio[1332]: info: CoreCommandRouter::volumioGetState Oct 16 23:30:21 volumio volumio[1332]: info: CorePlayQueue::getTrack 0 Oct 16 23:30:21 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 23:30:21 volumio volumio[1332]: info: CoreCommandRouter::volumioGetState Oct 16 23:30:21 volumio volumio[1332]: info: CorePlayQueue::getTrack 0 Oct 16 23:30:21 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 16 23:30:21 volumio volumio[1332]: info: CoreCommandRouter::volumioGetVisibleSources Oct 16 23:30:21 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 23:30:21 volumio volumio[1332]: info: CoreCommandRouter::volumioGetState Oct 16 23:30:21 volumio volumio[1332]: info: CorePlayQueue::getTrack 0 Oct 16 23:30:21 volumio volumio[1332]: info: CoreCommandRouter::volumioGetState Oct 16 23:30:21 volumio volumio[1332]: info: CorePlayQueue::getTrack 0 Oct 16 23:30:21 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 16 23:30:21 volumio volumio[1332]: info: CoreCommandRouter::volumioGetQueue Oct 16 23:30:21 volumio volumio[1332]: info: CoreStateMachine::getQueue Oct 16 23:30:21 volumio volumio[1332]: info: CorePlayQueue::getQueue Oct 16 23:30:21 volumio volumio[1332]: info: Listing playlists Oct 16 23:30:21 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 16 23:30:21 volumio volumio[1332]: info: Received Get System Info Oct 16 23:30:21 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 23:30:21 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 23:30:21 volumio volumio[1332]: info: Discovery: Getting this device information Oct 16 23:30:21 volumio volumio[1332]: info: CoreCommandRouter::volumioGetState Oct 16 23:30:21 volumio volumio[1332]: info: CorePlayQueue::getTrack 0 Oct 16 23:30:21 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 23:30:21 volumio volumio[1332]: info: CoreCommandRouter::volumioGetState Oct 16 23:30:21 volumio volumio[1332]: info: CorePlayQueue::getTrack 0 Oct 16 23:30:21 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 16 23:30:22 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 16 23:30:31 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 16 23:30:31 volumio volumio[1332]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Oct 16 23:30:31 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Oct 16 23:30:31 volumio volumio[1332]: info: Received Get System Version Oct 16 23:30:31 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 16 23:30:31 volumio volumio[1332]: info: Received Get System Info Oct 16 23:30:31 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 23:30:31 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 23:30:31 volumio volumio[1332]: info: Discovery: Getting this device information Oct 16 23:30:31 volumio volumio[1332]: info: CoreCommandRouter::volumioGetState Oct 16 23:30:31 volumio volumio[1332]: info: CorePlayQueue::getTrack 0 Oct 16 23:30:31 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 23:30:31 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 16 23:30:33 volumio volumio[1332]: info: CoreCommandRouter::volumioRandom Oct 16 23:30:33 volumio volumio[1332]: info: CoreCommandRouter::writePlayerControls Oct 16 23:30:33 volumio volumio[1332]: info: CorePlayQueue::getTrack 0 Oct 16 23:30:33 volumio volumio[1332]: info: CoreStateMachine::setRepeat true single true Oct 16 23:30:33 volumio volumio[1332]: info: CoreStateMachine::pushState Oct 16 23:30:33 volumio volumio[1332]: info: CorePlayQueue::getTrack 0 Oct 16 23:30:33 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 23:30:33 volumio volumio[1332]: info: CoreCommandRouter::volumioPushState Oct 16 23:30:33 volumio volumio[1332]: info: PeppySpectrum ---peppyspectrum status stop Oct 16 23:30:33 volumio sudo[2204]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Oct 16 23:30:33 volumio sudo[2204]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 23:30:33 volumio sudo[2204]: pam_unix(sudo:session): session closed for user root Oct 16 23:30:33 volumio volumio[1332]: info: peppyspectrum Daemon Stop Oct 16 23:30:33 volumio ntpd[1205]: Soliciting pool server 203.159.70.33 Oct 16 23:30:33 volumio volumio[1332]: info: CoreCommandRouter::volumioRandom Oct 16 23:30:33 volumio volumio[1332]: info: CoreCommandRouter::writePlayerControls Oct 16 23:30:33 volumio volumio[1332]: info: CorePlayQueue::getTrack 0 Oct 16 23:30:33 volumio volumio[1332]: info: CoreStateMachine::setRepeat false single false Oct 16 23:30:33 volumio volumio[1332]: info: CoreStateMachine::pushState Oct 16 23:30:33 volumio volumio[1332]: info: CorePlayQueue::getTrack 0 Oct 16 23:30:33 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 23:30:33 volumio volumio[1332]: info: CoreCommandRouter::volumioPushState Oct 16 23:30:33 volumio volumio[1332]: info: PeppySpectrum ---peppyspectrum status stop Oct 16 23:30:33 volumio sudo[2207]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Oct 16 23:30:33 volumio sudo[2207]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 23:30:33 volumio ntpd[1205]: Soliciting pool server 202.12.97.45 Oct 16 23:30:33 volumio sudo[2207]: pam_unix(sudo:session): session closed for user root Oct 16 23:30:33 volumio volumio[1332]: info: peppyspectrum Daemon Stop Oct 16 23:30:34 volumio volumio[1332]: info: CoreCommandRouter::volumioRandom Oct 16 23:30:34 volumio volumio[1332]: info: CoreCommandRouter::writePlayerControls Oct 16 23:30:34 volumio volumio[1332]: info: CorePlayQueue::getTrack 0 Oct 16 23:30:34 volumio volumio[1332]: info: CoreStateMachine::setRepeat true single false Oct 16 23:30:34 volumio volumio[1332]: info: CoreStateMachine::pushState Oct 16 23:30:34 volumio volumio[1332]: info: CorePlayQueue::getTrack 0 Oct 16 23:30:34 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 23:30:34 volumio volumio[1332]: info: CoreCommandRouter::volumioPushState Oct 16 23:30:34 volumio volumio[1332]: info: PeppySpectrum ---peppyspectrum status stop Oct 16 23:30:34 volumio sudo[2210]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Oct 16 23:30:34 volumio sudo[2210]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 23:30:34 volumio sudo[2210]: pam_unix(sudo:session): session closed for user root Oct 16 23:30:34 volumio volumio[1332]: info: peppyspectrum Daemon Stop Oct 16 23:30:34 volumio ntpd[1205]: Soliciting pool server 202.28.92.208 Oct 16 23:30:34 volumio volumio[1332]: info: CoreCommandRouter::volumioRandom Oct 16 23:30:34 volumio volumio[1332]: info: CoreCommandRouter::writePlayerControls Oct 16 23:30:34 volumio volumio[1332]: info: CorePlayQueue::getTrack 0 Oct 16 23:30:34 volumio volumio[1332]: info: CoreStateMachine::setRepeat true single true Oct 16 23:30:34 volumio volumio[1332]: info: CoreStateMachine::pushState Oct 16 23:30:34 volumio volumio[1332]: info: CorePlayQueue::getTrack 0 Oct 16 23:30:34 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 23:30:34 volumio volumio[1332]: info: CoreCommandRouter::volumioPushState Oct 16 23:30:34 volumio volumio[1332]: info: PeppySpectrum ---peppyspectrum status stop Oct 16 23:30:34 volumio sudo[2213]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Oct 16 23:30:34 volumio sudo[2213]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 23:30:34 volumio sudo[2213]: pam_unix(sudo:session): session closed for user root Oct 16 23:30:34 volumio volumio[1332]: info: peppyspectrum Daemon Stop Oct 16 23:30:34 volumio volumio[1332]: info: CoreCommandRouter::volumioRandom Oct 16 23:30:34 volumio volumio[1332]: info: CoreCommandRouter::writePlayerControls Oct 16 23:30:34 volumio volumio[1332]: info: CorePlayQueue::getTrack 0 Oct 16 23:30:34 volumio volumio[1332]: info: CoreStateMachine::setRepeat false single false Oct 16 23:30:34 volumio volumio[1332]: info: CoreStateMachine::pushState Oct 16 23:30:34 volumio volumio[1332]: info: CorePlayQueue::getTrack 0 Oct 16 23:30:34 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 23:30:34 volumio volumio[1332]: info: CoreCommandRouter::volumioPushState Oct 16 23:30:34 volumio volumio[1332]: info: PeppySpectrum ---peppyspectrum status stop Oct 16 23:30:34 volumio sudo[2216]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Oct 16 23:30:34 volumio sudo[2216]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 23:30:34 volumio sudo[2216]: pam_unix(sudo:session): session closed for user root Oct 16 23:30:34 volumio volumio[1332]: info: peppyspectrum Daemon Stop Oct 16 23:30:34 volumio ntpd[1205]: Soliciting pool server 202.28.33.225 Oct 16 23:30:34 volumio ntpd[1205]: Soliciting pool server 171.103.24.86 Oct 16 23:30:34 volumio ntpd[1205]: Soliciting pool server 202.28.116.236 Oct 16 23:30:35 volumio ntpd[1205]: Soliciting pool server 202.28.117.7 Oct 16 23:30:35 volumio ntpd[1205]: Soliciting pool server 124.109.2.169 Oct 16 23:30:35 volumio ntpd[1205]: Soliciting pool server 202.80.227.130 Oct 16 23:30:35 volumio ntpd[1205]: Soliciting pool server 122.155.180.231 Oct 16 23:30:35 volumio ntpd[1205]: Soliciting pool server 202.29.58.130 Oct 16 23:30:36 volumio ntpd[1205]: Soliciting pool server 2a05:dfc3:f751:ef3a:d7fe:3837:e723:dee2 Oct 16 23:30:42 volumio ntpd[1205]: receive: Unexpected origin timestamp 0xec9b9c30.d57d13bc does not match aorg 0000000000.00000000 from server@202.80.227.130 xmt 0xec9b9c32.00aeabf8 Oct 16 23:30:42 volumio ntpd[1205]: receive: Unexpected origin timestamp 0xec9b9c30.d57eaccc does not match aorg 0000000000.00000000 from server@202.12.97.45 xmt 0xec9b9c32.015ef395 Oct 16 23:30:42 volumio ntpd[1205]: receive: Unexpected origin timestamp 0xec9b9c30.d57e2b6b does not match aorg 0000000000.00000000 from server@202.28.92.208 xmt 0xec9b9c32.017e3973 Oct 16 23:30:42 volumio ntpd[1205]: receive: Unexpected origin timestamp 0xec9b9c30.d57b6d8d does not match aorg 0000000000.00000000 from server@202.29.58.130 xmt 0xec9b9c32.01bfdd72 Oct 16 23:30:45 volumio go-librespot[1571]: time="2025-10-16T23:30:45+07:00" level=trace msg="sent dealer ping" Oct 16 23:30:45 volumio go-librespot[1571]: time="2025-10-16T23:30:45+07:00" level=trace msg="received dealer pong" Oct 16 23:30:46 volumio volumio[1332]: info: CoreCommandRouter::volumioPlay Oct 16 23:30:46 volumio volumio[1332]: info: CoreStateMachine::play index 0 Oct 16 23:30:46 volumio volumio[1332]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 23:30:46 volumio volumio[1332]: info: CoreStateMachine::stop Oct 16 23:30:46 volumio volumio[1332]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 23:30:46 volumio volumio[1332]: info: CoreStateMachine::play index undefined Oct 16 23:30:46 volumio volumio[1332]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 23:30:46 volumio volumio[1332]: info: CorePlayQueue::getTrack 0 Oct 16 23:30:46 volumio volumio[1332]: info: CoreStateMachine::startPlaybackTimer Oct 16 23:30:46 volumio volumio[1332]: info: CorePlayQueue::getTrack 0 Oct 16 23:30:46 volumio volumio[1332]: verbose: ControllerMpd::clearAddPlayTracks USB/HMC-8_1_870/[Mp3] 100 เพลงดังฟังต่อเนื่อง 90s [Thai]/01 ไม่เอาคืน - ดัง พันกร.mp3 Oct 16 23:30:46 volumio volumio[1332]: verbose: ControllerMpd::sendMpdCommand stop Oct 16 23:30:46 volumio volumio[1332]: info: sendMpdCommand stop took 1 milliseconds Oct 16 23:30:46 volumio volumio[1332]: verbose: ControllerMpd::sendMpdCommand clear Oct 16 23:30:46 volumio volumio[1332]: info: Oct 16 23:30:46 volumio volumio[1332]: ---------------------------- MPD announces system playlist update Oct 16 23:30:46 volumio volumio[1332]: info: Ignoring MPD Status Update Oct 16 23:30:46 volumio volumio[1332]: info: sendMpdCommand clear took 1 milliseconds Oct 16 23:30:46 volumio volumio[1332]: verbose: ControllerMpd::sendMpdCommand add "USB/HMC-8_1_870/[Mp3] 100 เพลงดังฟังต่อเนื่อง 90s [Thai]/01 ไม่เอาคืน - ดัง พันกร.mp3" Oct 16 23:30:46 volumio volumio[1332]: error: updateQueue error: null Oct 16 23:30:46 volumio volumio[1332]: info: ------------------------------ 1ms Oct 16 23:30:48 volumio volumio[1332]: info: CoreCommandRouter::volumioClearQueue Oct 16 23:30:48 volumio volumio[1332]: info: CoreStateMachine::ClearQueue Oct 16 23:30:48 volumio volumio[1332]: info: CoreStateMachine::stop Oct 16 23:30:48 volumio volumio[1332]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 23:30:48 volumio volumio[1332]: info: CorePlayQueue::clearPlayQueue Oct 16 23:30:48 volumio volumio[1332]: info: CorePlayQueue::saveQueue Oct 16 23:30:48 volumio volumio[1332]: info: CoreCommandRouter::volumioPushState Oct 16 23:30:48 volumio volumio[1332]: info: CoreCommandRouter::volumioPushQueue Oct 16 23:30:48 volumio volumio[1332]: info: PeppySpectrum ---peppyspectrum status stop Oct 16 23:30:48 volumio sudo[2236]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Oct 16 23:30:48 volumio sudo[2236]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 23:30:48 volumio sudo[2236]: pam_unix(sudo:session): session closed for user root Oct 16 23:30:48 volumio volumio[1332]: info: peppyspectrum Daemon Stop Oct 16 23:30:50 volumio volumio[1332]: info: CoreCommandRouter::volumioClearQueue Oct 16 23:30:50 volumio volumio[1332]: info: CoreStateMachine::ClearQueue Oct 16 23:30:50 volumio volumio[1332]: info: CoreStateMachine::stop Oct 16 23:30:50 volumio volumio[1332]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 23:30:50 volumio volumio[1332]: info: CorePlayQueue::clearPlayQueue Oct 16 23:30:50 volumio volumio[1332]: info: CorePlayQueue::saveQueue Oct 16 23:30:50 volumio volumio[1332]: info: CoreCommandRouter::volumioPushState Oct 16 23:30:50 volumio volumio[1332]: info: CoreCommandRouter::volumioPushQueue Oct 16 23:30:50 volumio volumio[1332]: info: CoreCommandRouter::volumioClearQueue Oct 16 23:30:50 volumio volumio[1332]: info: CoreStateMachine::ClearQueue Oct 16 23:30:50 volumio volumio[1332]: info: CoreStateMachine::stop Oct 16 23:30:50 volumio volumio[1332]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 23:30:50 volumio volumio[1332]: info: CorePlayQueue::clearPlayQueue Oct 16 23:30:50 volumio volumio[1332]: info: CorePlayQueue::saveQueue Oct 16 23:30:50 volumio volumio[1332]: info: CoreCommandRouter::volumioPushState Oct 16 23:30:50 volumio volumio[1332]: info: CoreCommandRouter::volumioPushQueue Oct 16 23:30:50 volumio volumio[1332]: info: PeppySpectrum ---peppyspectrum status stop Oct 16 23:30:50 volumio volumio[1332]: info: PeppySpectrum ---peppyspectrum status stop Oct 16 23:30:50 volumio sudo[2239]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Oct 16 23:30:50 volumio sudo[2239]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 23:30:50 volumio sudo[2242]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Oct 16 23:30:50 volumio sudo[2242]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 23:30:50 volumio sudo[2239]: pam_unix(sudo:session): session closed for user root Oct 16 23:30:50 volumio volumio[1332]: info: peppyspectrum Daemon Stop Oct 16 23:30:50 volumio sudo[2242]: pam_unix(sudo:session): session closed for user root Oct 16 23:30:50 volumio volumio[1332]: info: peppyspectrum Daemon Stop Oct 16 23:30:50 volumio volumio[1332]: info: CoreCommandRouter::volumioClearQueue Oct 16 23:30:50 volumio volumio[1332]: info: CoreStateMachine::ClearQueue Oct 16 23:30:50 volumio volumio[1332]: info: CoreStateMachine::stop Oct 16 23:30:50 volumio volumio[1332]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 23:30:50 volumio volumio[1332]: info: CorePlayQueue::clearPlayQueue Oct 16 23:30:50 volumio volumio[1332]: info: CorePlayQueue::saveQueue Oct 16 23:30:50 volumio volumio[1332]: info: CoreCommandRouter::volumioPushState Oct 16 23:30:50 volumio volumio[1332]: info: CoreCommandRouter::volumioPushQueue Oct 16 23:30:50 volumio volumio[1332]: info: PeppySpectrum ---peppyspectrum status stop Oct 16 23:30:50 volumio sudo[2245]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Oct 16 23:30:50 volumio sudo[2245]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 23:30:50 volumio sudo[2245]: pam_unix(sudo:session): session closed for user root Oct 16 23:30:50 volumio volumio[1332]: info: peppyspectrum Daemon Stop Oct 16 23:30:53 volumio volumio[1332]: info: CoreCommandRouter::volumioGetState Oct 16 23:30:53 volumio volumio[1332]: info: CorePlayQueue::getTrack 0 Oct 16 23:30:59 volumio volumio[1332]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 16 23:30:59 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 16 23:30:59 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 23:30:59 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 16 23:30:59 volumio volumio[1332]: info: Getting Alsa Cards List without I2S DAC Oct 16 23:30:59 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Oct 16 23:30:59 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 23:30:59 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 16 23:30:59 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 16 23:30:59 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 16 23:30:59 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 16 23:30:59 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 16 23:30:59 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 16 23:30:59 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 16 23:30:59 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Oct 16 23:30:59 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 16 23:31:08 volumio volumio[1332]: info: CoreCommandRouter::volumioGetState Oct 16 23:31:08 volumio volumio[1332]: info: CorePlayQueue::getTrack 0 Oct 16 23:31:15 volumio go-librespot[1571]: time="2025-10-16T23:31:15+07:00" level=trace msg="sent dealer ping" Oct 16 23:31:15 volumio go-librespot[1571]: time="2025-10-16T23:31:15+07:00" level=trace msg="received dealer pong" Oct 16 23:31:32 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 16 23:31:32 volumio volumio[1332]: info: CURURI: music-library Oct 16 23:31:32 volumio volumio[1332]: error: Failed LSINFO: null Oct 16 23:31:32 volumio volumio[1332]: info: Preload queue cleared Oct 16 23:31:39 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 16 23:31:39 volumio volumio[1332]: info: Preload queue cleared Oct 16 23:31:40 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 16 23:31:40 volumio volumio[1332]: info: Preload queue cleared Oct 16 23:31:45 volumio go-librespot[1571]: time="2025-10-16T23:31:45+07:00" level=trace msg="received accesspoint ping" Oct 16 23:31:45 volumio go-librespot[1571]: time="2025-10-16T23:31:45+07:00" level=trace msg="received accesspoint pong ack" Oct 16 23:31:45 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 16 23:31:45 volumio go-librespot[1571]: time="2025-10-16T23:31:45+07:00" level=trace msg="sent dealer ping" Oct 16 23:31:45 volumio go-librespot[1571]: time="2025-10-16T23:31:45+07:00" level=trace msg="received dealer pong" Oct 16 23:31:46 volumio volumio[1332]: info: Preload queue cleared Oct 16 23:31:46 volumio volumio[1332]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg' Oct 16 23:31:49 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 16 23:31:49 volumio volumio[1332]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 16 23:31:49 volumio volumio[1332]: TypeError: Cannot read property 'length' of undefined Oct 16 23:31:49 volumio volumio[1332]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Oct 16 23:31:49 volumio volumio[1332]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Oct 16 23:31:49 volumio volumio[1332]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Oct 16 23:31:49 volumio volumio[1332]: at Parser.emit (events.js:315:20) Oct 16 23:31:49 volumio volumio[1332]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Oct 16 23:31:49 volumio volumio[1332]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Oct 16 23:31:49 volumio volumio[1332]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Oct 16 23:31:49 volumio volumio[1332]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Oct 16 23:31:49 volumio volumio[1332]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Oct 16 23:31:49 volumio volumio[1332]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Oct 16 23:31:49 volumio volumio[1332]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Oct 16 23:31:49 volumio volumio[1332]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Oct 16 23:31:49 volumio volumio[1332]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Oct 16 23:31:49 volumio volumio[1332]: at IncomingMessage.emit (events.js:327:22) Oct 16 23:31:49 volumio volumio[1332]: at endReadableNT (internal/streams/readable.js:1327:12) Oct 16 23:31:49 volumio volumio[1332]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Oct 16 23:31:49 volumio volumio[1332]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 16 23:31:49 volumio sudo[2400]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-16 23:30 Oct 16 23:31:49 volumio sudo[2400]: 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="29866754e5f1d7e4d0f581c10d9f22852f6f21db" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 10:25:36 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="cf6e14681b2ecbbdc9a62186b0f3114c"