-- Logs begin at Sun 2025-05-04 13:40:56 EDT, end at Sun 2025-05-04 14:07:47 EDT. -- May 04 14:06:11 volumio volumio[1249]: verbose: New Socket.io Connection to 192.168.1.119 from 192.168.1.250 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_4_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.4 Mobile/15E148 Safari/604.1 Engine version: 3 Transport: polling Total Clients: 5 May 04 14:06:11 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 04 14:06:11 volumio volumio[1249]: info: CoreCommandRouter::volumioGetVisibleSources May 04 14:06:11 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 04 14:06:11 volumio volumio[1249]: info: CoreCommandRouter::volumioGetState May 04 14:06:11 volumio volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 14:06:11 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 04 14:06:11 volumio volumio[1249]: info: CoreCommandRouter::volumioGetQueue May 04 14:06:11 volumio volumio[1249]: info: CoreStateMachine::getQueue May 04 14:06:11 volumio volumio[1249]: info: CorePlayQueue::getQueue May 04 14:06:11 volumio volumio[1249]: info: Listing playlists May 04 14:06:11 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 04 14:06:11 volumio volumio[1249]: info: Received Get System Info May 04 14:06:11 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 04 14:06:11 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 04 14:06:11 volumio volumio[1249]: info: Discovery: Getting this device information May 04 14:06:11 volumio volumio[1249]: info: CoreCommandRouter::volumioGetState May 04 14:06:11 volumio volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 14:06:11 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 04 14:06:11 volumio volumio[1249]: info: CoreCommandRouter::volumioGetState May 04 14:06:11 volumio volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 14:06:11 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 04 14:06:12 volumio volumio[1249]: info: CoreCommandRouter::volumioPause May 04 14:06:12 volumio volumio[1249]: info: CoreStateMachine::pause May 04 14:06:12 volumio volumio[1249]: info: CoreStateMachine::stPlaybackTimer May 04 14:06:12 volumio volumio[1249]: info: CoreStateMachine::servicePause May 04 14:06:12 volumio volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 14:06:12 volumio volumio[1249]: info: CoreCommandRouter::servicePause May 04 14:06:12 volumio volumio[1249]: info: ControllerMpd::pause May 04 14:06:12 volumio volumio[1249]: verbose: ControllerMpd::sendMpdCommand pause May 04 14:06:12 volumio volumio[1249]: info: May 04 14:06:12 volumio volumio[1249]: ---------------------------- MPD announces state update: player May 04 14:06:12 volumio volumio[1249]: info: sendMpdCommand pause took 1 milliseconds May 04 14:06:12 volumio volumio[1249]: info: ControllerMpd::getState May 04 14:06:12 volumio volumio[1249]: verbose: ControllerMpd::sendMpdCommand status May 04 14:06:12 volumio volumio[1249]: info: May 04 14:06:12 volumio volumio[1249]: ---------------------------- MPD announces state update: player May 04 14:06:12 volumio volumio[1249]: info: ControllerMpd::getState May 04 14:06:12 volumio volumio[1249]: verbose: ControllerMpd::sendMpdCommand status May 04 14:06:12 volumio volumio[1249]: info: May 04 14:06:12 volumio volumio[1249]: ---------------------------- MPD announces state update: player May 04 14:06:12 volumio volumio[1249]: info: ControllerMpd::getState May 04 14:06:12 volumio volumio[1249]: verbose: ControllerMpd::sendMpdCommand status May 04 14:06:12 volumio volumio[1249]: info: sendMpdCommand status took 0 milliseconds May 04 14:06:12 volumio volumio[1249]: info: sendMpdCommand status took 0 milliseconds May 04 14:06:12 volumio volumio[1249]: verbose: ControllerMpd::parseState May 04 14:06:12 volumio volumio[1249]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 14:06:12 volumio volumio[1249]: verbose: ControllerMpd::parseState May 04 14:06:12 volumio volumio[1249]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 14:06:12 volumio volumio[1249]: info: sendMpdCommand status took 0 milliseconds May 04 14:06:12 volumio volumio[1249]: info: sendMpdCommand playlistinfo took 0 milliseconds May 04 14:06:12 volumio volumio[1249]: info: sendMpdCommand playlistinfo took 0 milliseconds May 04 14:06:12 volumio volumio[1249]: verbose: ControllerMpd::parseState May 04 14:06:12 volumio volumio[1249]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 14:06:12 volumio volumio[1249]: verbose: ControllerMpd::parseTrackInfo May 04 14:06:12 volumio volumio[1249]: verbose: ControllerMpd::parseTrackInfo May 04 14:06:12 volumio volumio[1249]: info: ControllerMpd::pushState May 04 14:06:12 volumio volumio[1249]: info: CoreCommandRouter::servicePushState May 04 14:06:12 volumio volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 14:06:12 volumio volumio[1249]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":100604,"duration":206,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01 If You Could Read My Mind.wav","artist":null,"album":null,"uri":"NAS/Music/CD Collection/Studio 54 – Music From the Miramax Motion Picture – Volume 2/01 If You Could Read My Mind.wav","trackType":"wav"} May 04 14:06:12 volumio volumio[1249]: verbose: CURRENT POSITION 0 May 04 14:06:12 volumio volumio[1249]: info: CoreStateMachine::syncState stateService pause May 04 14:06:12 volumio volumio[1249]: info: CoreStateMachine::syncState currentStatus pause May 04 14:06:12 volumio volumio[1249]: info: CoreStateMachine::pushState May 04 14:06:12 volumio volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 14:06:12 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 04 14:06:12 volumio volumio[1249]: info: CoreCommandRouter::volumioPushState May 04 14:06:12 volumio volumio[1249]: info: CoreStateMachine::stPlaybackTimer May 04 14:06:12 volumio volumio[1249]: info: ControllerMpd::pushState May 04 14:06:12 volumio volumio[1249]: info: CoreCommandRouter::servicePushState May 04 14:06:12 volumio volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 14:06:12 volumio volumio[1249]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":100604,"duration":206,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01 If You Could Read My Mind.wav","artist":null,"album":null,"uri":"NAS/Music/CD Collection/Studio 54 – Music From the Miramax Motion Picture – Volume 2/01 If You Could Read My Mind.wav","trackType":"wav"} May 04 14:06:12 volumio volumio[1249]: verbose: CURRENT POSITION 0 May 04 14:06:12 volumio volumio[1249]: info: CoreStateMachine::syncState stateService pause May 04 14:06:12 volumio volumio[1249]: info: CoreStateMachine::syncState currentStatus pause May 04 14:06:12 volumio volumio[1249]: info: CoreStateMachine::pushState May 04 14:06:12 volumio volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 14:06:12 volumio volumio[1249]: info: CoreCommandRouter::volumioPushState May 04 14:06:12 volumio volumio[1249]: info: CoreStateMachine::stPlaybackTimer May 04 14:06:12 volumio volumio[1249]: info: ------------------------------ 4ms May 04 14:06:12 volumio volumio[1249]: info: ------------------------------ 3ms May 04 14:06:12 volumio volumio[1249]: info: sendMpdCommand playlistinfo took 3 milliseconds May 04 14:06:12 volumio volumio[1249]: verbose: ControllerMpd::parseTrackInfo May 04 14:06:12 volumio volumio[1249]: info: ControllerMpd::pushState May 04 14:06:12 volumio volumio[1249]: info: CoreCommandRouter::servicePushState May 04 14:06:12 volumio volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 14:06:12 volumio volumio[1249]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":100604,"duration":206,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01 If You Could Read My Mind.wav","artist":null,"album":null,"uri":"NAS/Music/CD Collection/Studio 54 – Music From the Miramax Motion Picture – Volume 2/01 If You Could Read My Mind.wav","trackType":"wav"} May 04 14:06:12 volumio volumio[1249]: verbose: CURRENT POSITION 0 May 04 14:06:12 volumio volumio[1249]: info: CoreStateMachine::syncState stateService pause May 04 14:06:12 volumio volumio[1249]: info: CoreStateMachine::syncState currentStatus pause May 04 14:06:12 volumio volumio[1249]: info: CoreStateMachine::pushState May 04 14:06:12 volumio volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 14:06:12 volumio volumio[1249]: info: CoreCommandRouter::volumioPushState May 04 14:06:12 volumio volumio[1249]: info: CoreStateMachine::stPlaybackTimer May 04 14:06:12 volumio volumio[1249]: info: ------------------------------ 4ms May 04 14:07:01 volumio kernel: CIFS: VFS: \\192.168.1.127 has not responded in 180 seconds. Reconnecting... May 04 14:07:25 volumio volumio[1249]: verbose: New Socket.io Connection to 192.168.1.119 from 192.168.1.250 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_4_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.4 Mobile/15E148 Safari/604.1 Engine version: 3 Transport: polling Total Clients: 5 May 04 14:07:25 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 04 14:07:25 volumio volumio[1249]: info: CoreCommandRouter::volumioGetVisibleSources May 04 14:07:25 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 04 14:07:25 volumio volumio[1249]: info: CoreCommandRouter::volumioGetState May 04 14:07:25 volumio volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 14:07:25 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 04 14:07:25 volumio volumio[1249]: info: CoreCommandRouter::volumioGetQueue May 04 14:07:25 volumio volumio[1249]: info: CoreStateMachine::getQueue May 04 14:07:25 volumio volumio[1249]: info: CorePlayQueue::getQueue May 04 14:07:25 volumio volumio[1249]: info: Listing playlists May 04 14:07:25 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 04 14:07:25 volumio volumio[1249]: info: Received Get System Info May 04 14:07:25 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 04 14:07:25 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 04 14:07:25 volumio volumio[1249]: info: Discovery: Getting this device information May 04 14:07:25 volumio volumio[1249]: info: CoreCommandRouter::volumioGetState May 04 14:07:25 volumio volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 14:07:25 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 04 14:07:25 volumio volumio[1249]: info: CoreCommandRouter::volumioGetState May 04 14:07:25 volumio volumio[1249]: info: CorePlayQueue::getTrack 0 May 04 14:07:25 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 04 14:07:34 volumio volumio[1249]: info: CoreCommandRouter::getUIConfigOnPlugin May 04 14:07:34 volumio volumio[1249]: info: CoreCommandRouter::getUIConfigOnPlugin May 04 14:07:34 volumio volumio[1249]: info: Retrieving Cloud Streaming UI May 04 14:07:34 volumio volumio[1249]: info: Getting Tidal Cloud Configuration May 04 14:07:34 volumio volumio[1249]: info: CoreCommandRouter::getUIConfigOnPlugin May 04 14:07:34 volumio volumio[1249]: info: Getting Qobuz Cloud Configuration May 04 14:07:34 volumio volumio[1249]: info: Asking plugin for UI Config May 04 14:07:34 volumio volumio[1249]: info: CoreCommandRouter::getUIConfigOnPlugin May 04 14:07:34 volumio volumio[1249]: info: Getting Spotify Cloud Configuration May 04 14:07:34 volumio volumio[1249]: info: Asking plugin for UI Config May 04 14:07:34 volumio volumio[1249]: info: CoreCommandRouter::getUIConfigOnPlugin May 04 14:07:34 volumio volumio[1249]: info: Saving Spotify Acccount May 04 14:07:34 volumio volumio[1249]: info: Got Tidal Cloud Configuration May 04 14:07:34 volumio volumio[1249]: info: Got it May 04 14:07:34 volumio volumio[1249]: info: Got it May 04 14:07:34 volumio volumio[1249]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 04 14:07:34 volumio volumio[1249]: info: CoreCommandRouter::getUIConfigOnPlugin May 04 14:07:34 volumio volumio[1249]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined May 04 14:07:34 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 04 14:07:34 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 04 14:07:34 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 04 14:07:34 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 04 14:07:34 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 04 14:07:34 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 04 14:07:34 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 04 14:07:34 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 04 14:07:34 volumio volumio[1249]: info: CoreCommandRouter::volumioGetBrowseSources May 04 14:07:34 volumio volumio[1249]: info: CoreCommandRouter::volumioGetBrowseSources May 04 14:07:34 volumio volumio[1249]: info: CoreCommandRouter::volumioGetBrowseSources May 04 14:07:34 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 04 14:07:34 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 04 14:07:38 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 04 14:07:42 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 04 14:07:42 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares May 04 14:07:42 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService May 04 14:07:43 volumio volumio[1249]: info: Executing SMB command: smbclient --no-pass --debuglevel=0 -L Qnap.local. May 04 14:07:43 volumio volumio[1249]: info: Executing SMB command: smbclient --no-pass --debuglevel=0 -L EPSON92D145.local. May 04 14:07:43 volumio volumio[1249]: info: Error browsing device Qnap for shares: Command failed: smbclient --no-pass --debuglevel=0 -L Qnap.local. May 04 14:07:43 volumio volumio[1249]: Unable to initialize messaging context May 04 14:07:46 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 04 14:07:47 volumio volumio[1249]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 04 14:07:47 volumio volumio[1249]: Error: dns service error: unknown May 04 14:07:47 volumio volumio[1249]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30) May 04 14:07:47 volumio volumio[1249]: at SocketWatcher.MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { May 04 14:07:47 volumio volumio[1249]: errorCode: -65537 May 04 14:07:47 volumio volumio[1249]: } May 04 14:07:47 volumio volumio[1249]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 04 14:07:47 volumio sudo[6227]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-04 14:06 May 04 14:07:47 volumio sudo[6227]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="9ab87de061b3649c303da550e73c92d340b0f989" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 24 Apr 2025 10:07:11 AM CEST" VOLUMIO_VERSION="3.804" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="dc77d77f02ef88ea816c3d31de871e8f"