Apr 11 09:37:00 volumio volumio[5197]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
Apr 11 09:37:00 volumio volumio[5197]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
Apr 11 09:37:00 volumio volumio[5197]: info: Streaming services startup
Apr 11 09:37:00 volumio volumio[5197]: info: Starting Streaming Daemon
Apr 11 09:37:00 volumio sudo[5529]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Apr 11 09:37:00 volumio volumio[5197]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started
Apr 11 09:37:00 volumio sudo[5529]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 11 09:37:00 volumio sudo[5529]: pam_unix(sudo:session): session closed for user root
Apr 11 09:37:00 volumio volumio[5197]: error: Cannot start Volumio Streaming Daemon
Apr 11 09:37:00 volumio volumio[5197]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Apr 11 09:37:00 volumio volumio[5197]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Apr 11 09:37:09 volumio volumio[5197]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 11 09:37:09 volumio volumio[5197]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 11 09:37:09 volumio volumio[5197]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Apr 11 09:37:09 volumio volumio-remote-updater[821]: Test mode disabled
Apr 11 09:37:09 volumio volumio-remote-updater[821]: Alpha mode disabled
Apr 11 09:37:09 volumio volumio-remote-updater[821]: Alpha legacy test mode disabled
Apr 11 09:37:09 volumio volumio[5197]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Apr 11 09:37:14 volumio volumio[5197]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Apr 11 09:37:14 volumio volumio[5197]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Apr 11 09:37:15 volumio volumio[5197]: info: CoreCommandRouter::volumioGetState
Apr 11 09:37:15 volumio volumio[5197]: info: CorePlayQueue::getTrack 0
Apr 11 09:37:15 volumio volumio[5197]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false}
Apr 11 09:37:15 volumio volumio[5197]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Apr 11 09:37:19 volumio volumio[5197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 09:37:19 volumio volumio[5197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 09:37:19 volumio volumio[5197]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Apr 11 09:37:19 volumio volumio[5197]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Apr 11 09:37:19 volumio volumio[5197]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Apr 11 09:37:19 volumio volumio[5197]: info: CoreCommandRouter::volumioGetBrowseSources
Apr 11 09:37:19 volumio volumio[5197]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 11 09:37:20 volumio volumio[5197]: error: MyVolumio Plugin failed to authenticate in a timely fashion
Apr 11 09:37:20 volumio volumio[5197]: info: Completed starting MyVolumio Plugin
Apr 11 09:37:20 volumio volumio[5197]: [Metrics] CommandRouter: 46s 148.83ms
Apr 11 09:37:20 volumio volumio[5197]: info: CoreCommandRouter::volumiosetStartupVolume
Apr 11 09:37:20 volumio volumio[5197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 09:37:20 volumio volumio[5197]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 11 09:37:20 volumio volumio[5197]: info: CoreCommandRouter::Close All Modals sent
Apr 11 09:37:20 volumio volumio[5197]: info: CoreCommandRouter::Close All Modals sent
Apr 11 09:37:21 volumio systemd[1]: Starting systemd-tmpfiles-clean.service - Cleanup of Temporary Directories...
Apr 11 09:37:21 volumio systemd[1]: systemd-tmpfiles-clean.service: Deactivated successfully.
Apr 11 09:37:21 volumio systemd[1]: Finished systemd-tmpfiles-clean.service - Cleanup of Temporary Directories.
Apr 11 09:37:21 volumio systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dclean.service.mount: Deactivated successfully.
Apr 11 09:37:21 volumio volumio[5197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Apr 11 09:37:21 volumio volumio[5197]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Apr 11 09:37:21 volumio volumio[5197]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Apr 11 09:37:27 volumio volumio[5197]: info: BOOT COMPLETED
Apr 11 09:37:28 volumio volumio5-onboarding[2058]: time=2026-04-11T09:37:28.350+08:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.0.66:51622
Apr 11 09:37:28 volumio volumio[5197]: verbose: New Socket.io Connection to 192.168.0.202 from 192.168.0.66 UA: Mozilla/5.0 (Linux; Android 16; V2366GA Build/BP2A.250605.031.A3_MOD1; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/146.0.7680.177 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10
Apr 11 09:37:28 volumio volumio[5197]: info: CoreCommandRouter::volumioGetState
Apr 11 09:37:28 volumio volumio[5197]: info: CorePlayQueue::getTrack 0
Apr 11 09:37:28 volumio volumio[5197]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Apr 11 09:37:28 volumio volumio[5197]: info: Listing playlists
Apr 11 09:37:28 volumio volumio[5197]: info: CoreCommandRouter::volumioGetQueue
Apr 11 09:37:28 volumio volumio[5197]: info: CoreStateMachine::getQueue
Apr 11 09:37:28 volumio volumio[5197]: info: CorePlayQueue::getQueue
Apr 11 09:37:28 volumio volumio[5197]: info: CoreCommandRouter::volumioGetVisibleSources
Apr 11 09:37:28 volumio volumio[5197]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 11 09:37:33 volumio volumio5-onboarding[2058]: time=2026-04-11T09:37:33.780+08:00 level=INFO msg="WebSocket connection closed" component=conn/ws remoteAddr=192.168.0.66:51622
Apr 11 09:37:33 volumio volumio5-onboarding[2058]: time=2026-04-11T09:37:33.781+08:00 level=INFO msg="connection to address closed" component=conn/multi addr=192.168.0.66:51622
Apr 11 09:37:33 volumio volumio5-onboarding[2058]: time=2026-04-11T09:37:33.791+08:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.0.66:51640
Apr 11 09:37:38 volumio volumio[5197]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Apr 11 09:37:38 volumio volumio[5197]: info: CURURI: albums://Red%20Holloway/Jazz%20That's%20Soulfully%20Blue
Apr 11 09:37:38 volumio volumio[5197]: info: Preload queue cleared
Apr 11 09:37:38 volumio volumio[5197]: info: Preloading song: music-library/NAS/CloudNAS/[爵士]SACDISO-一点灵魂一点蓝调.Various.Artists[Jazz.That's.Soulfully.Blue]/Jazz That's Soulfully Blue/02 - Red Holloway - A Tear In My Heart.dsf
Apr 11 09:37:38 volumio volumio[5197]: info: Preloading song: music-library/NAS/CloudNAS/[爵士]SACDISO-一点灵魂一点蓝调.Various.Artists[Jazz.That's.Soulfully(1).Blue]/Jazz That's Soulfully Blue/02 - Red Holloway - A Tear In My Heart.dsf
Apr 11 09:37:38 volumio volumio[5197]: info: Exploding uri music-library/NAS/CloudNAS/[爵士]SACDISO-一点灵魂一点蓝调.Various.Artists[Jazz.That's.Soulfully.Blue]/Jazz That's Soulfully Blue/02 - Red Holloway - A Tear In My Heart.dsf in service mpd
Apr 11 09:37:38 volumio volumio[5197]: info: ALBUMART /albumart?cacheid=112&web=Red%20Holloway/Jazz%20That's%20Soulfully%20Blue/extralarge&path=%2Fmnt%2FNAS%2FCloudNAS%2F%5B%E7%88%B5%E5%A3%AB%5DSACDISO-%E4%B8%80%E7%82%B9%E7%81%B5%E9%AD%82%E4%B8%80%E7%82%B9%E8%93%9D%E8%B0%83.Various.Artists%5BJazz.That's.Soulfully.Blue%5D%2FJazz%20That's%20Soulfully%20Blue%2F02%20-%20Red%20Holloway%20-%20A%20Tear%20In%20My%20Heart.dsf&metadata=false
Apr 11 09:37:38 volumio volumio[5197]: info: URI /mnt/NAS/CloudNAS/[爵士]SACDISO-一点灵魂一点蓝调.Various.Artists[Jazz.That's.Soulfully.Blue]/Jazz That's Soulfully Blue/02 - Red Holloway - A Tear In My Heart.dsf
Apr 11 09:37:38 volumio volumio[5197]: info: Exploding uri music-library/NAS/CloudNAS/[爵士]SACDISO-一点灵魂一点蓝调.Various.Artists[Jazz.That's.Soulfully(1).Blue]/Jazz That's Soulfully Blue/02 - Red Holloway - A Tear In My Heart.dsf in service mpd
Apr 11 09:37:38 volumio volumio[5197]: info: ALBUMART /albumart?cacheid=112&web=Red%20Holloway/Jazz%20That's%20Soulfully%20Blue/extralarge&path=%2Fmnt%2FNAS%2FCloudNAS%2F%5B%E7%88%B5%E5%A3%AB%5DSACDISO-%E4%B8%80%E7%82%B9%E7%81%B5%E9%AD%82%E4%B8%80%E7%82%B9%E8%93%9D%E8%B0%83.Various.Artists%5BJazz.That's.Soulfully(1).Blue%5D%2FJazz%20That's%20Soulfully%20Blue%2F02%20-%20Red%20Holloway%20-%20A%20Tear%20In%20My%20Heart.dsf&metadata=false
Apr 11 09:37:38 volumio volumio[5197]: info: URI /mnt/NAS/CloudNAS/[爵士]SACDISO-一点灵魂一点蓝调.Various.Artists[Jazz.That's.Soulfully(1).Blue]/Jazz That's Soulfully Blue/02 - Red Holloway - A Tear In My Heart.dsf
Apr 11 09:37:41 volumio volumio[5197]: info: Preload queue cleared
Apr 11 09:37:41 volumio volumio[5197]: info: CoreCommandRouter::volumioReplaceandPlayItems
Apr 11 09:37:41 volumio volumio[5197]: info: CoreStateMachine::ClearQueue
Apr 11 09:37:41 volumio volumio[5197]: info: CoreStateMachine::stop
Apr 11 09:37:41 volumio volumio[5197]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 11 09:37:41 volumio volumio[5197]: info: CorePlayQueue::clearPlayQueue
Apr 11 09:37:41 volumio volumio[5197]: info: CorePlayQueue::saveQueue
Apr 11 09:37:41 volumio volumio[5197]: info: CoreCommandRouter::volumioPushQueue
Apr 11 09:37:41 volumio volumio[5197]: info: CoreStateMachine::addQueueItems
Apr 11 09:37:41 volumio volumio[5197]: info: CorePlayQueue::addQueueItems
Apr 11 09:37:41 volumio volumio[5197]: info: Preload queue cleared
Apr 11 09:37:41 volumio volumio[5197]: info: Adding Item to queue: music-library/NAS/CloudNAS/[爵士]SACDISO-一点灵魂一点蓝调.Various.Artists[Jazz.That's.Soulfully.Blue]/Jazz That's Soulfully Blue/02 - Red Holloway - A Tear In My Heart.dsf
Apr 11 09:37:41 volumio volumio[5197]: info: Using cached record of: music-library/NAS/CloudNAS/[爵士]SACDISO-一点灵魂一点蓝调.Various.Artists[Jazz.That's.Soulfully.Blue]/Jazz That's Soulfully Blue/02 - Red Holloway - A Tear In My Heart.dsf
Apr 11 09:37:41 volumio volumio[5197]: info: CoreCommandRouter::volumioPushQueue
Apr 11 09:37:41 volumio volumio[5197]: info: CorePlayQueue::saveQueue
Apr 11 09:37:41 volumio volumio[5197]: info: CoreStateMachine::updateTrackBlock
Apr 11 09:37:41 volumio volumio[5197]: info: CorePlayQueue::getTrackBlock
Apr 11 09:37:41 volumio volumio[5197]: info: CoreCommandRouter::volumioPlay
Apr 11 09:37:41 volumio volumio[5197]: info: CoreStateMachine::play index 0
Apr 11 09:37:41 volumio volumio[5197]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 11 09:37:41 volumio volumio[5197]: info: CoreStateMachine::addQueueItems
Apr 11 09:37:41 volumio volumio[5197]: info: CorePlayQueue::addQueueItems
Apr 11 09:37:41 volumio volumio[5197]: info: Preload queue cleared
Apr 11 09:37:41 volumio volumio[5197]: info: Adding Item to queue: music-library/NAS/CloudNAS/[爵士]SACDISO-一点灵魂一点蓝调.Various.Artists[Jazz.That's.Soulfully(1).Blue]/Jazz That's Soulfully Blue/02 - Red Holloway - A Tear In My Heart.dsf
Apr 11 09:37:41 volumio volumio[5197]: info: Using cached record of: music-library/NAS/CloudNAS/[爵士]SACDISO-一点灵魂一点蓝调.Various.Artists[Jazz.That's.Soulfully(1).Blue]/Jazz That's Soulfully Blue/02 - Red Holloway - A Tear In My Heart.dsf
Apr 11 09:37:41 volumio volumio[5197]: info: CoreStateMachine::stop
Apr 11 09:37:41 volumio volumio[5197]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 11 09:37:41 volumio volumio[5197]: info: CoreCommandRouter::volumioPushQueue
Apr 11 09:37:41 volumio volumio[5197]: info: CorePlayQueue::saveQueue
Apr 11 09:37:41 volumio volumio[5197]: info: CoreStateMachine::play index undefined
Apr 11 09:37:41 volumio volumio[5197]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 11 09:37:41 volumio volumio[5197]: info: CoreStateMachine::updateTrackBlock
Apr 11 09:37:41 volumio volumio[5197]: info: CorePlayQueue::getTrackBlock
Apr 11 09:37:41 volumio volumio[5197]: info: CorePlayQueue::getTrack 0
Apr 11 09:37:41 volumio volumio[5197]: info: CoreStateMachine::startPlaybackTimer
Apr 11 09:37:41 volumio volumio[5197]: info: CorePlayQueue::getTrack 0
Apr 11 09:37:41 volumio volumio[5197]: verbose: ControllerMpd::clearAddPlayTracks NAS/CloudNAS/[爵士]SACDISO-一点灵魂一点蓝调.Various.Artists[Jazz.That's.Soulfully.Blue]/Jazz That's Soulfully Blue/02 - Red Holloway - A Tear In My Heart.dsf
Apr 11 09:37:41 volumio volumio[5197]: info: Setting Volume to 100 automatically for DSD
Apr 11 09:37:41 volumio volumio[5197]: info: VolumeController::SetAlsaVolume100
Apr 11 09:37:41 volumio volumio[5197]: verbose: ControllerMpd::sendMpdCommand stop
Apr 11 09:37:41 volumio volumio[5197]: info: CoreStateMachine::pushState
Apr 11 09:37:41 volumio volumio[5197]: info: CorePlayQueue::getTrack 0
Apr 11 09:37:41 volumio volumio[5197]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 09:37:41 volumio volumio[5197]: info: CoreCommandRouter::volumioPushState
Apr 11 09:37:41 volumio volumio5-onboarding[2058]: time=2026-04-11T09:37:41.231+08:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.66:51640 @ 0xc0004621b0" state=STATUS_STOPPED positionMs=0 volume=100
Apr 11 09:37:41 volumio volumio5-onboarding[2058]: time=2026-04-11T09:37:41.231+08:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.66:51640 @ 0xc0004621b0" id="mnt/NAS/CloudNAS/[爵士]SACDISO-一点灵魂一点蓝调.Various.Artists[Jazz.That's.Soulfully.Blue]/Jazz That's Soulfully Blue/02 - Red Holloway - A Tear In My Heart.dsf" title="A Tear In My Heart"
Apr 11 09:37:41 volumio volumio[5197]: info: sendMpdCommand stop took 36 milliseconds
Apr 11 09:37:41 volumio volumio[5197]: verbose: ControllerMpd::sendMpdCommand clear
Apr 11 09:37:41 volumio volumio[5197]: info:
Apr 11 09:37:41 volumio volumio[5197]: ---------------------------- MPD announces system playlist update
Apr 11 09:37:41 volumio volumio[5197]: info: Ignoring MPD Status Update
Apr 11 09:37:41 volumio volumio[5197]: info: sendMpdCommand clear took 8 milliseconds
Apr 11 09:37:41 volumio volumio[5197]: verbose: ControllerMpd::sendMpdCommand add "NAS/CloudNAS/[爵士]SACDISO-一点灵魂一点蓝调.Various.Artists[Jazz.That's.Soulfully.Blue]/Jazz That's Soulfully Blue/02 - Red Holloway - A Tear In My Heart.dsf"
Apr 11 09:37:41 volumio volumio[5197]: info:
Apr 11 09:37:41 volumio volumio[5197]: ---------------------------- MPD announces system playlist update
Apr 11 09:37:41 volumio volumio[5197]: info: Ignoring MPD Status Update
Apr 11 09:37:41 volumio volumio[5197]: info:
Apr 11 09:37:41 volumio volumio[5197]: ---------------------------- MPD announces system playlist update
Apr 11 09:37:41 volumio volumio[5197]: info: Ignoring MPD Status Update
Apr 11 09:37:41 volumio volumio[5197]: error: updateQueue error: null
Apr 11 09:37:41 volumio volumio[5197]: info:
Apr 11 09:37:41 volumio volumio[5197]: ---------------------------- MPD announces system playlist update
Apr 11 09:37:41 volumio volumio[5197]: info: Ignoring MPD Status Update
Apr 11 09:37:41 volumio volumio[5197]: info: ------------------------------ 41ms
Apr 11 09:37:41 volumio volumio[5197]: info: sendMpdCommand add "NAS/CloudNAS/[爵士]SACDISO-一点灵魂一点蓝调.Various.Artists[Jazz.That's.Soulfully.Blue]/Jazz That's Soulfully Blue/02 - Red Holloway - A Tear In My Heart.dsf" took 38 milliseconds
Apr 11 09:37:41 volumio volumio[5197]: info: ------------------------------ 37ms
Apr 11 09:37:41 volumio volumio[5197]: info: ------------------------------ 36ms
Apr 11 09:37:41 volumio volumio[5197]: verbose: ControllerMpd::sendMpdCommand play
Apr 11 09:37:41 volumio volumio[5197]: info:
Apr 11 09:37:41 volumio volumio[5197]: ---------------------------- MPD announces system playlist update
Apr 11 09:37:41 volumio volumio[5197]: info: Ignoring MPD Status Update
Apr 11 09:37:41 volumio volumio[5197]: info:
Apr 11 09:37:41 volumio volumio[5197]: ---------------------------- MPD announces system playlist update
Apr 11 09:37:41 volumio volumio[5197]: info: Ignoring MPD Status Update
Apr 11 09:37:41 volumio volumio[5197]: info: ------------------------------ 18ms
Apr 11 09:37:41 volumio volumio[5197]: info: sendMpdCommand play took 15 milliseconds
Apr 11 09:37:41 volumio volumio[5197]: info: ------------------------------ 15ms
Apr 11 09:37:41 volumio volumio[5197]: info: ------------------------------ 14ms
Apr 11 09:37:42 volumio volumio[5197]: info:
Apr 11 09:37:42 volumio volumio[5197]: ---------------------------- MPD announces state update: player
Apr 11 09:37:42 volumio volumio[5197]: info: ControllerMpd::getState
Apr 11 09:37:42 volumio volumio[5197]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 09:37:42 volumio volumio[5197]: info:
Apr 11 09:37:42 volumio volumio[5197]: ---------------------------- MPD announces state update: player
Apr 11 09:37:42 volumio volumio[5197]: info: ControllerMpd::getState
Apr 11 09:37:42 volumio volumio[5197]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 09:37:42 volumio volumio[5197]: info:
Apr 11 09:37:42 volumio volumio[5197]: ---------------------------- MPD announces state update: player
Apr 11 09:37:42 volumio volumio[5197]: info: ControllerMpd::getState
Apr 11 09:37:42 volumio volumio[5197]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 09:37:42 volumio volumio[5197]: info:
Apr 11 09:37:42 volumio volumio[5197]: ---------------------------- MPD announces state update: player
Apr 11 09:37:42 volumio volumio[5197]: info: sendMpdCommand status took 64 milliseconds
Apr 11 09:37:42 volumio volumio[5197]: info: ControllerMpd::getState
Apr 11 09:37:42 volumio volumio[5197]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 09:37:42 volumio volumio[5197]: verbose: ControllerMpd::parseState
Apr 11 09:37:42 volumio volumio[5197]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 09:37:42 volumio volumio[5197]: info:
Apr 11 09:37:42 volumio volumio[5197]: ---------------------------- MPD announces state update: player
Apr 11 09:37:42 volumio volumio[5197]: info: ControllerMpd::getState
Apr 11 09:37:42 volumio volumio[5197]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 09:37:42 volumio volumio[5197]: info: sendMpdCommand status took 70 milliseconds
Apr 11 09:37:42 volumio volumio[5197]: info: sendMpdCommand status took 70 milliseconds
Apr 11 09:37:42 volumio volumio[5197]: info: sendMpdCommand status took 7 milliseconds
Apr 11 09:37:42 volumio volumio[5197]: info: sendMpdCommand playlistinfo took 6 milliseconds
Apr 11 09:37:42 volumio volumio[5197]: info: sendMpdCommand status took 4 milliseconds
Apr 11 09:37:42 volumio volumio[5197]: verbose: ControllerMpd::parseState
Apr 11 09:37:42 volumio volumio[5197]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 09:37:42 volumio volumio[5197]: verbose: ControllerMpd::parseState
Apr 11 09:37:42 volumio volumio[5197]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 09:37:42 volumio volumio[5197]: verbose: ControllerMpd::parseState
Apr 11 09:37:42 volumio volumio[5197]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 09:37:42 volumio volumio[5197]: verbose: ControllerMpd::parseTrackInfo
Apr 11 09:37:42 volumio volumio[5197]: verbose: ControllerMpd::parseState
Apr 11 09:37:42 volumio volumio[5197]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 09:37:42 volumio volumio[5197]: info: ControllerMpd::pushState
Apr 11 09:37:42 volumio volumio[5197]: info: CoreCommandRouter::servicePushState
Apr 11 09:37:42 volumio volumio[5197]: info: CorePlayQueue::getTrack 0
Apr 11 09:37:42 volumio volumio[5197]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":347,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"A Tear In My Heart","artist":"Red Holloway","album":"Jazz That's Soulfully Blue","uri":"NAS/CloudNAS/[爵士]SACDISO-一点灵魂一点蓝调.Various.Artists[Jazz.That's.Soulfully.Blue]/Jazz That's Soulfully Blue/02 - Red Holloway - A Tear In My Heart.dsf","trackType":"dsf"}
Apr 11 09:37:42 volumio volumio[5197]: verbose: CURRENT POSITION 0
Apr 11 09:37:42 volumio volumio[5197]: info: CoreStateMachine::syncState stateService play
Apr 11 09:37:42 volumio volumio[5197]: info: CoreStateMachine::syncState currentStatus stop
Apr 11 09:37:42 volumio volumio[5197]: info: ------------------------------ 84ms
Apr 11 09:37:42 volumio volumio[5197]: info:
Apr 11 09:37:42 volumio volumio[5197]: ---------------------------- MPD announces state update: player
Apr 11 09:37:42 volumio volumio[5197]: info: ControllerMpd::getState
Apr 11 09:37:42 volumio volumio[5197]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 09:37:42 volumio volumio[5197]: info: sendMpdCommand playlistinfo took 10 milliseconds
Apr 11 09:37:42 volumio volumio[5197]: info: sendMpdCommand playlistinfo took 11 milliseconds
Apr 11 09:37:42 volumio volumio[5197]: info: sendMpdCommand playlistinfo took 10 milliseconds
Apr 11 09:37:42 volumio volumio[5197]: info: sendMpdCommand playlistinfo took 8 milliseconds
Apr 11 09:37:42 volumio volumio[5197]: info: sendMpdCommand status took 2 milliseconds
Apr 11 09:37:42 volumio volumio[5197]: verbose: ControllerMpd::parseTrackInfo
Apr 11 09:37:42 volumio volumio[5197]: verbose: ControllerMpd::parseTrackInfo
Apr 11 09:37:42 volumio volumio[5197]: verbose: ControllerMpd::parseTrackInfo
Apr 11 09:37:42 volumio volumio[5197]: verbose: ControllerMpd::parseTrackInfo
Apr 11 09:37:42 volumio volumio[5197]: verbose: ControllerMpd::parseState
Apr 11 09:37:42 volumio volumio[5197]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 09:37:42 volumio volumio[5197]: info: ControllerMpd::pushState
Apr 11 09:37:42 volumio volumio[5197]: info: CoreCommandRouter::servicePushState
Apr 11 09:37:42 volumio volumio[5197]: info: CorePlayQueue::getTrack 0
Apr 11 09:37:42 volumio volumio[5197]: verbose: STATE SERVICE {"status":"play","position":0,"seek":490,"duration":347,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"A Tear In My Heart","artist":"Red Holloway","album":"Jazz That's Soulfully Blue","uri":"NAS/CloudNAS/[爵士]SACDISO-一点灵魂一点蓝调.Various.Artists[Jazz.That's.Soulfully.Blue]/Jazz That's Soulfully Blue/02 - Red Holloway - A Tear In My Heart.dsf","trackType":"dsf"}
Apr 11 09:37:42 volumio volumio[5197]: verbose: CURRENT POSITION 0
Apr 11 09:37:42 volumio volumio[5197]: info: CoreStateMachine::syncState stateService play
Apr 11 09:37:42 volumio volumio[5197]: info: CoreStateMachine::syncState currentStatus play
Apr 11 09:37:42 volumio volumio[5197]: info: Received an update from plugin. extracting info from payload
Apr 11 09:37:42 volumio volumio[5197]: info: CoreStateMachine::pushState
Apr 11 09:37:42 volumio volumio[5197]: info: CorePlayQueue::getTrack 0
Apr 11 09:37:42 volumio volumio[5197]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 09:37:42 volumio volumio[5197]: info: CoreCommandRouter::volumioPushState
Apr 11 09:37:42 volumio volumio[5197]: info: CoreStateMachine::pushState
Apr 11 09:37:42 volumio volumio[5197]: info: CorePlayQueue::getTrack 0
Apr 11 09:37:42 volumio volumio[5197]: info: CoreCommandRouter::volumioPushState
Apr 11 09:37:42 volumio volumio[5197]: info: ControllerMpd::pushState
Apr 11 09:37:42 volumio volumio[5197]: info: CoreCommandRouter::servicePushState
Apr 11 09:37:42 volumio volumio[5197]: info: CorePlayQueue::getTrack 0
Apr 11 09:37:42 volumio volumio[5197]: verbose: STATE SERVICE {"status":"play","position":0,"seek":861,"duration":347,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"A Tear In My Heart","artist":"Red Holloway","album":"Jazz That's Soulfully Blue","uri":"NAS/CloudNAS/[爵士]SACDISO-一点灵魂一点蓝调.Various.Artists[Jazz.That's.Soulfully.Blue]/Jazz That's Soulfully Blue/02 - Red Holloway - A Tear In My Heart.dsf","trackType":"dsf"}
Apr 11 09:37:42 volumio volumio[5197]: verbose: CURRENT POSITION 0
Apr 11 09:37:42 volumio volumio[5197]: info: CoreStateMachine::syncState stateService play
Apr 11 09:37:42 volumio volumio[5197]: info: CoreStateMachine::syncState currentStatus play
Apr 11 09:37:42 volumio volumio[5197]: info: Received an update from plugin. extracting info from payload
Apr 11 09:37:42 volumio volumio[5197]: info: CoreStateMachine::pushState
Apr 11 09:37:42 volumio volumio[5197]: info: CorePlayQueue::getTrack 0
Apr 11 09:37:42 volumio volumio[5197]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 09:37:42 volumio volumio[5197]: info: CoreCommandRouter::volumioPushState
Apr 11 09:37:42 volumio volumio[5197]: info: CoreStateMachine::pushState
Apr 11 09:37:42 volumio volumio[5197]: info: CorePlayQueue::getTrack 0
Apr 11 09:37:42 volumio volumio[5197]: info: CoreCommandRouter::volumioPushState
Apr 11 09:37:42 volumio volumio[5197]: info: ControllerMpd::pushState
Apr 11 09:37:42 volumio volumio[5197]: info: CoreCommandRouter::servicePushState
Apr 11 09:37:42 volumio volumio[5197]: info: CorePlayQueue::getTrack 0
Apr 11 09:37:42 volumio volumio[5197]: verbose: STATE SERVICE {"status":"play","position":0,"seek":986,"duration":347,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"A Tear In My Heart","artist":"Red Holloway","album":"Jazz That's Soulfully Blue","uri":"NAS/CloudNAS/[爵士]SACDISO-一点灵魂一点蓝调.Various.Artists[Jazz.That's.Soulfully.Blue]/Jazz That's Soulfully Blue/02 - Red Holloway - A Tear In My Heart.dsf","trackType":"dsf"}
Apr 11 09:37:42 volumio volumio[5197]: verbose: CURRENT POSITION 0
Apr 11 09:37:42 volumio volumio[5197]: info: CoreStateMachine::syncState stateService play
Apr 11 09:37:42 volumio volumio[5197]: info: CoreStateMachine::syncState currentStatus play
Apr 11 09:37:42 volumio volumio[5197]: info: Received an update from plugin. extracting info from payload
Apr 11 09:37:42 volumio volumio[5197]: info: CoreStateMachine::pushState
Apr 11 09:37:42 volumio volumio[5197]: info: CorePlayQueue::getTrack 0
Apr 11 09:37:42 volumio volumio[5197]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 09:37:42 volumio volumio[5197]: info: CoreCommandRouter::volumioPushState
Apr 11 09:37:42 volumio volumio[5197]: info: CoreStateMachine::pushState
Apr 11 09:37:42 volumio volumio[5197]: info: CorePlayQueue::getTrack 0
Apr 11 09:37:42 volumio volumio[5197]: info: CoreCommandRouter::volumioPushState
Apr 11 09:37:42 volumio volumio[5197]: info: ControllerMpd::pushState
Apr 11 09:37:42 volumio volumio[5197]: info: CoreCommandRouter::servicePushState
Apr 11 09:37:42 volumio volumio[5197]: info: CorePlayQueue::getTrack 0
Apr 11 09:37:42 volumio volumio[5197]: verbose: STATE SERVICE {"status":"play","position":0,"seek":992,"duration":347,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"A Tear In My Heart","artist":"Red Holloway","album":"Jazz That's Soulfully Blue","uri":"NAS/CloudNAS/[爵士]SACDISO-一点灵魂一点蓝调.Various.Artists[Jazz.That's.Soulfully.Blue]/Jazz That's Soulfully Blue/02 - Red Holloway - A Tear In My Heart.dsf","trackType":"dsf"}
Apr 11 09:37:42 volumio volumio[5197]: verbose: CURRENT POSITION 0
Apr 11 09:37:42 volumio volumio[5197]: info: CoreStateMachine::syncState stateService play
Apr 11 09:37:42 volumio volumio[5197]: info: CoreStateMachine::syncState currentStatus play
Apr 11 09:37:42 volumio volumio[5197]: info: Received an update from plugin. extracting info from payload
Apr 11 09:37:42 volumio volumio[5197]: info: CoreStateMachine::pushState
Apr 11 09:37:42 volumio volumio[5197]: info: CorePlayQueue::getTrack 0
Apr 11 09:37:42 volumio volumio[5197]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 09:37:42 volumio volumio[5197]: info: CoreCommandRouter::volumioPushState
Apr 11 09:37:42 volumio volumio[5197]: info: CoreStateMachine::pushState
Apr 11 09:37:42 volumio volumio[5197]: info: CorePlayQueue::getTrack 0
Apr 11 09:37:42 volumio volumio[5197]: info: CoreCommandRouter::volumioPushState
Apr 11 09:37:42 volumio volumio5-onboarding[2058]: time=2026-04-11T09:37:42.329+08:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.66:51640 @ 0xc0004621b0" state=STATUS_PLAYING positionMs=490 volume=100
Apr 11 09:37:42 volumio volumio5-onboarding[2058]: time=2026-04-11T09:37:42.329+08:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.66:51640 @ 0xc0004621b0" id="mnt/NAS/CloudNAS/[爵士]SACDISO-一点灵魂一点蓝调.Various.Artists[Jazz.That's.Soulfully.Blue]/Jazz That's Soulfully Blue/02 - Red Holloway - A Tear In My Heart.dsf" title="A Tear In My Heart"
Apr 11 09:37:42 volumio volumio5-onboarding[2058]: time=2026-04-11T09:37:42.331+08:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.66:51640 @ 0xc0004621b0" state=STATUS_PLAYING positionMs=490 volume=100
Apr 11 09:37:42 volumio volumio5-onboarding[2058]: time=2026-04-11T09:37:42.331+08:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.66:51640 @ 0xc0004621b0" id="mnt/NAS/CloudNAS/[爵士]SACDISO-一点灵魂一点蓝调.Various.Artists[Jazz.That's.Soulfully.Blue]/Jazz That's Soulfully Blue/02 - Red Holloway - A Tear In My Heart.dsf" title="A Tear In My Heart"
Apr 11 09:37:42 volumio volumio5-onboarding[2058]: time=2026-04-11T09:37:42.332+08:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.66:51640 @ 0xc0004621b0" state=STATUS_PLAYING positionMs=861 volume=100
Apr 11 09:37:42 volumio volumio5-onboarding[2058]: time=2026-04-11T09:37:42.332+08:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.66:51640 @ 0xc0004621b0" id="mnt/NAS/CloudNAS/[爵士]SACDISO-一点灵魂一点蓝调.Various.Artists[Jazz.That's.Soulfully.Blue]/Jazz That's Soulfully Blue/02 - Red Holloway - A Tear In My Heart.dsf" title="A Tear In My Heart"
Apr 11 09:37:42 volumio volumio5-onboarding[2058]: time=2026-04-11T09:37:42.333+08:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.66:51640 @ 0xc0004621b0" state=STATUS_PLAYING positionMs=861 volume=100
Apr 11 09:37:42 volumio volumio5-onboarding[2058]: time=2026-04-11T09:37:42.333+08:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.66:51640 @ 0xc0004621b0" id="mnt/NAS/CloudNAS/[爵士]SACDISO-一点灵魂一点蓝调.Various.Artists[Jazz.That's.Soulfully.Blue]/Jazz That's Soulfully Blue/02 - Red Holloway - A Tear In My Heart.dsf" title="A Tear In My Heart"
Apr 11 09:37:42 volumio volumio5-onboarding[2058]: time=2026-04-11T09:37:42.334+08:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.66:51640 @ 0xc0004621b0" state=STATUS_PLAYING positionMs=986 volume=100
Apr 11 09:37:42 volumio volumio5-onboarding[2058]: time=2026-04-11T09:37:42.334+08:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.66:51640 @ 0xc0004621b0" id="mnt/NAS/CloudNAS/[爵士]SACDISO-一点灵魂一点蓝调.Various.Artists[Jazz.That's.Soulfully.Blue]/Jazz That's Soulfully Blue/02 - Red Holloway - A Tear In My Heart.dsf" title="A Tear In My Heart"
Apr 11 09:37:42 volumio volumio5-onboarding[2058]: time=2026-04-11T09:37:42.335+08:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.66:51640 @ 0xc0004621b0" state=STATUS_PLAYING positionMs=986 volume=100
Apr 11 09:37:42 volumio volumio5-onboarding[2058]: time=2026-04-11T09:37:42.335+08:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.66:51640 @ 0xc0004621b0" id="mnt/NAS/CloudNAS/[爵士]SACDISO-一点灵魂一点蓝调.Various.Artists[Jazz.That's.Soulfully.Blue]/Jazz That's Soulfully Blue/02 - Red Holloway - A Tear In My Heart.dsf" title="A Tear In My Heart"
Apr 11 09:37:42 volumio volumio5-onboarding[2058]: time=2026-04-11T09:37:42.336+08:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.66:51640 @ 0xc0004621b0" state=STATUS_PLAYING positionMs=992 volume=100
Apr 11 09:37:42 volumio volumio5-onboarding[2058]: time=2026-04-11T09:37:42.337+08:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.66:51640 @ 0xc0004621b0" id="mnt/NAS/CloudNAS/[爵士]SACDISO-一点灵魂一点蓝调.Various.Artists[Jazz.That's.Soulfully.Blue]/Jazz That's Soulfully Blue/02 - Red Holloway - A Tear In My Heart.dsf" title="A Tear In My Heart"
Apr 11 09:37:42 volumio volumio5-onboarding[2058]: time=2026-04-11T09:37:42.338+08:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.66:51640 @ 0xc0004621b0" state=STATUS_PLAYING positionMs=992 volume=100
Apr 11 09:37:42 volumio volumio5-onboarding[2058]: time=2026-04-11T09:37:42.338+08:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.66:51640 @ 0xc0004621b0" id="mnt/NAS/CloudNAS/[爵士]SACDISO-一点灵魂一点蓝调.Various.Artists[Jazz.That's.Soulfully.Blue]/Jazz That's Soulfully Blue/02 - Red Holloway - A Tear In My Heart.dsf" title="A Tear In My Heart"
Apr 11 09:37:42 volumio volumio[5197]: info: ------------------------------ 188ms
Apr 11 09:37:42 volumio volumio[5197]: info: ------------------------------ 188ms
Apr 11 09:37:42 volumio volumio[5197]: info: ------------------------------ 127ms
Apr 11 09:37:42 volumio volumio[5197]: info: ------------------------------ 123ms
Apr 11 09:37:42 volumio volumio[5197]: info: sendMpdCommand playlistinfo took 106 milliseconds
Apr 11 09:37:42 volumio volumio[5197]: verbose: ControllerMpd::parseTrackInfo
Apr 11 09:37:42 volumio volumio[5197]: info: ControllerMpd::pushState
Apr 11 09:37:42 volumio volumio[5197]: info: CoreCommandRouter::servicePushState
Apr 11 09:37:42 volumio volumio[5197]: info: CorePlayQueue::getTrack 0
Apr 11 09:37:42 volumio volumio[5197]: verbose: STATE SERVICE {"status":"play","position":0,"seek":992,"duration":347,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"A Tear In My Heart","artist":"Red Holloway","album":"Jazz That's Soulfully Blue","uri":"NAS/CloudNAS/[爵士]SACDISO-一点灵魂一点蓝调.Various.Artists[Jazz.That's.Soulfully.Blue]/Jazz That's Soulfully Blue/02 - Red Holloway - A Tear In My Heart.dsf","trackType":"dsf"}
Apr 11 09:37:42 volumio volumio[5197]: verbose: CURRENT POSITION 0
Apr 11 09:37:42 volumio volumio[5197]: info: CoreStateMachine::syncState stateService play
Apr 11 09:37:42 volumio volumio[5197]: info: CoreStateMachine::syncState currentStatus play
Apr 11 09:37:42 volumio volumio[5197]: info: Received an update from plugin. extracting info from payload
Apr 11 09:37:42 volumio volumio[5197]: info: CoreStateMachine::pushState
Apr 11 09:37:42 volumio volumio[5197]: info: CorePlayQueue::getTrack 0
Apr 11 09:37:42 volumio volumio[5197]: info: CoreCommandRouter::volumioPushState
Apr 11 09:37:42 volumio volumio[5197]: info: CoreStateMachine::pushState
Apr 11 09:37:42 volumio volumio[5197]: info: CorePlayQueue::getTrack 0
Apr 11 09:37:42 volumio volumio[5197]: info: CoreCommandRouter::volumioPushState
Apr 11 09:37:42 volumio volumio5-onboarding[2058]: time=2026-04-11T09:37:42.420+08:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.66:51640 @ 0xc0004621b0" state=STATUS_PLAYING positionMs=992 volume=100
Apr 11 09:37:42 volumio volumio5-onboarding[2058]: time=2026-04-11T09:37:42.421+08:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.66:51640 @ 0xc0004621b0" id="mnt/NAS/CloudNAS/[爵士]SACDISO-一点灵魂一点蓝调.Various.Artists[Jazz.That's.Soulfully.Blue]/Jazz That's Soulfully Blue/02 - Red Holloway - A Tear In My Heart.dsf" title="A Tear In My Heart"
Apr 11 09:37:42 volumio volumio5-onboarding[2058]: time=2026-04-11T09:37:42.421+08:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.66:51640 @ 0xc0004621b0" state=STATUS_PLAYING positionMs=992 volume=100
Apr 11 09:37:42 volumio volumio5-onboarding[2058]: time=2026-04-11T09:37:42.422+08:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.66:51640 @ 0xc0004621b0" id="mnt/NAS/CloudNAS/[爵士]SACDISO-一点灵魂一点蓝调.Various.Artists[Jazz.That's.Soulfully.Blue]/Jazz That's Soulfully Blue/02 - Red Holloway - A Tear In My Heart.dsf" title="A Tear In My Heart"
Apr 11 09:37:42 volumio volumio[5197]: info: ------------------------------ 148ms
Apr 11 09:38:11 volumio volumio[5197]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 11 09:38:11 volumio volumio[5197]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 11 09:38:11 volumio volumio[5197]: info: Discovery: Getting this device information
Apr 11 09:38:11 volumio volumio[5197]: info: CoreCommandRouter::volumioGetState
Apr 11 09:38:11 volumio volumio[5197]: info: CorePlayQueue::getTrack 0
Apr 11 09:38:11 volumio volumio[5197]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 11 09:38:11 volumio volumio[5197]: verbose: New Socket.io Connection to 192.168.0.202:3000 from 192.168.0.66 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 8
Apr 11 09:38:11 volumio volumio[5197]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Apr 11 09:38:11 volumio volumio[5197]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Apr 11 09:38:16 volumio nmbd[1078]: [2026/04/11 09:38:16.792595, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response)
Apr 11 09:38:16 volumio nmbd[1078]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.0.202 for name WORKGROUP<1d>.
Apr 11 09:38:16 volumio nmbd[1078]: This response was from IP 192.168.0.40, reporting an IP address of 192.168.0.42.
Apr 11 09:38:16 volumio nmbd[1078]: [2026/04/11 09:38:16.792933, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response)
Apr 11 09:38:16 volumio nmbd[1078]: query_name_response: Multiple (3) responses received for a query on subnet 192.168.0.202 for name WORKGROUP<1d>.
Apr 11 09:38:16 volumio nmbd[1078]: This response was from IP 192.168.0.40, reporting an IP address of 192.168.0.42.
Apr 11 09:38:16 volumio nmbd[1078]: [2026/04/11 09:38:16.793139, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response)
Apr 11 09:38:16 volumio nmbd[1078]: query_name_response: Multiple (4) responses received for a query on subnet 192.168.0.202 for name WORKGROUP<1d>.
Apr 11 09:38:16 volumio nmbd[1078]: This response was from IP 192.168.0.40, reporting an IP address of 192.168.0.42.
Apr 11 09:38:16 volumio nmbd[1078]: [2026/04/11 09:38:16.793342, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response)
Apr 11 09:38:16 volumio nmbd[1078]: query_name_response: Multiple (5) responses received for a query on subnet 192.168.0.202 for name WORKGROUP<1d>.
Apr 11 09:38:16 volumio nmbd[1078]: This response was from IP 192.168.0.41, reporting an IP address of 192.168.0.42.
Apr 11 09:38:16 volumio nmbd[1078]: [2026/04/11 09:38:16.793631, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response)
Apr 11 09:38:16 volumio nmbd[1078]: query_name_response: Multiple (6) responses received for a query on subnet 192.168.0.202 for name WORKGROUP<1d>.
Apr 11 09:38:16 volumio nmbd[1078]: This response was from IP 192.168.0.41, reporting an IP address of 192.168.0.42.
Apr 11 09:38:16 volumio nmbd[1078]: [2026/04/11 09:38:16.793842, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response)
Apr 11 09:38:16 volumio nmbd[1078]: query_name_response: Multiple (7) responses received for a query on subnet 192.168.0.202 for name WORKGROUP<1d>.
Apr 11 09:38:16 volumio nmbd[1078]: This response was from IP 192.168.0.42, reporting an IP address of 192.168.0.42.
Apr 11 09:38:16 volumio nmbd[1078]: [2026/04/11 09:38:16.794270, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response)
Apr 11 09:38:16 volumio nmbd[1078]: query_name_response: Multiple (8) responses received for a query on subnet 192.168.0.202 for name WORKGROUP<1d>.
Apr 11 09:38:16 volumio nmbd[1078]: This response was from IP 192.168.0.42, reporting an IP address of 192.168.0.42.
Apr 11 09:38:16 volumio nmbd[1078]: [2026/04/11 09:38:16.866989, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response)
Apr 11 09:38:16 volumio nmbd[1078]: query_name_response: Multiple (9) responses received for a query on subnet 192.168.0.202 for name WORKGROUP<1d>.
Apr 11 09:38:16 volumio nmbd[1078]: This response was from IP 192.168.0.40, reporting an IP address of 192.168.0.42.
Apr 11 09:38:16 volumio nmbd[1078]: [2026/04/11 09:38:16.867306, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response)
Apr 11 09:38:16 volumio nmbd[1078]: query_name_response: Multiple (10) responses received for a query on subnet 192.168.0.202 for name WORKGROUP<1d>.
Apr 11 09:38:16 volumio nmbd[1078]: This response was from IP 192.168.0.40, reporting an IP address of 192.168.0.42.
Apr 11 09:38:16 volumio nmbd[1078]: [2026/04/11 09:38:16.867533, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response)
Apr 11 09:38:16 volumio nmbd[1078]: query_name_response: Multiple (11) responses received for a query on subnet 192.168.0.202 for name WORKGROUP<1d>.
Apr 11 09:38:16 volumio nmbd[1078]: This response was from IP 192.168.0.41, reporting an IP address of 192.168.0.42.
Apr 11 09:38:16 volumio nmbd[1078]: [2026/04/11 09:38:16.870074, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response)
Apr 11 09:38:16 volumio nmbd[1078]: query_name_response: Multiple (12) responses received for a query on subnet 192.168.0.202 for name WORKGROUP<1d>.
Apr 11 09:38:16 volumio nmbd[1078]: This response was from IP 192.168.0.42, reporting an IP address of 192.168.0.42.
Apr 11 09:38:25 volumio volumio5-onboarding[2058]: time=2026-04-11T09:38:25.846+08:00 level=ERROR msg="failed to read message" component=conn/ws remoteAddr=192.168.0.66:51640 error="read tcp 192.168.0.202:7331->192.168.0.66:51640: read: connection reset by peer"
Apr 11 09:38:25 volumio volumio5-onboarding[2058]: time=2026-04-11T09:38:25.846+08:00 level=INFO msg="WebSocket connection closed" component=conn/ws remoteAddr=192.168.0.66:51640
Apr 11 09:38:25 volumio volumio5-onboarding[2058]: time=2026-04-11T09:38:25.846+08:00 level=INFO msg="connection to address closed" component=conn/multi addr=192.168.0.66:51640
Apr 11 09:38:55 volumio volumio[5197]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 11 09:38:55 volumio volumio[5197]: Error: connect ETIMEDOUT 108.160.167.158:443
Apr 11 09:38:55 volumio volumio[5197]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) {
Apr 11 09:38:55 volumio volumio[5197]: errno: -110,
Apr 11 09:38:55 volumio volumio[5197]: code: 'ETIMEDOUT',
Apr 11 09:38:55 volumio volumio[5197]: syscall: 'connect',
Apr 11 09:38:55 volumio volumio[5197]: address: '108.160.167.158',
Apr 11 09:38:55 volumio volumio[5197]: port: 443
Apr 11 09:38:55 volumio volumio[5197]: }
Apr 11 09:38:55 volumio volumio[5197]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 11 09:38:55 volumio sudo[5856]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-04-11 09:37'
Apr 11 09:38:55 volumio sudo[5856]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
PRETTY_NAME="Debian GNU/Linux 12 (bookworm)"
NAME="Debian GNU/Linux"
VERSION_ID="12"
VERSION="12 (bookworm)"
VERSION_CODENAME=bookworm
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="18952480e8d8c63f22208e9007a0f47a9563eae6"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue Mar 24 17:45:45 UTC 2026"
VOLUMIO_VERSION="4.119"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="6bf7cd61fe53483b72878254df87f1c0"