-- Logs begin at Thu 2019-02-14 19:11:59 JST, end at Sun 2025-08-31 09:16:32 JST. -- Aug 31 09:15:12 raspberrypi3 volumio[937]: info: CoreCommandRouter::volumioPlay Aug 31 09:15:12 raspberrypi3 volumio[937]: info: CoreStateMachine::play index undefined Aug 31 09:15:12 raspberrypi3 volumio[937]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 09:15:12 raspberrypi3 volumio[937]: info: CorePlayQueue::getTrack 0 Aug 31 09:15:12 raspberrypi3 volumio[937]: info: CoreStateMachine::startPlaybackTimer Aug 31 09:15:12 raspberrypi3 volumio[937]: info: CorePlayQueue::getTrack 0 Aug 31 09:15:12 raspberrypi3 volumio[937]: verbose: ControllerMpd::clearAddPlayTracks USB/KIOXIA/Best of TWO STEPS FROM HELL - TOP 25 TRACKS _ TSFH Vol 2.mp4 Aug 31 09:15:12 raspberrypi3 volumio[937]: verbose: ControllerMpd::sendMpdCommand stop Aug 31 09:15:12 raspberrypi3 volumio[937]: info: sendMpdCommand stop took 2 milliseconds Aug 31 09:15:12 raspberrypi3 volumio[937]: verbose: ControllerMpd::sendMpdCommand clear Aug 31 09:15:12 raspberrypi3 volumio[937]: info: sendMpdCommand clear took 1 milliseconds Aug 31 09:15:12 raspberrypi3 volumio[937]: verbose: ControllerMpd::sendMpdCommand add "USB/KIOXIA/Best of TWO STEPS FROM HELL - TOP 25 TRACKS _ TSFH Vol 2.mp4" Aug 31 09:15:12 raspberrypi3 volumio[937]: info: Aug 31 09:15:12 raspberrypi3 volumio[937]: ---------------------------- MPD announces system playlist update Aug 31 09:15:12 raspberrypi3 volumio[937]: info: Ignoring MPD Status Update Aug 31 09:15:12 raspberrypi3 volumio[937]: info: Aug 31 09:15:12 raspberrypi3 volumio[937]: ---------------------------- MPD announces system playlist update Aug 31 09:15:12 raspberrypi3 volumio[937]: info: Ignoring MPD Status Update Aug 31 09:15:12 raspberrypi3 volumio[937]: info: sendMpdCommand add "USB/KIOXIA/Best of TWO STEPS FROM HELL - TOP 25 TRACKS _ TSFH Vol 2.mp4" took 4 milliseconds Aug 31 09:15:12 raspberrypi3 volumio[937]: verbose: ControllerMpd::sendMpdCommand play Aug 31 09:15:12 raspberrypi3 volumio[937]: info: Aug 31 09:15:12 raspberrypi3 volumio[937]: ---------------------------- MPD announces system playlist update Aug 31 09:15:12 raspberrypi3 volumio[937]: info: Ignoring MPD Status Update Aug 31 09:15:12 raspberrypi3 volumio[937]: info: Aug 31 09:15:12 raspberrypi3 volumio[937]: ---------------------------- MPD announces system playlist update Aug 31 09:15:12 raspberrypi3 volumio[937]: info: Ignoring MPD Status Update Aug 31 09:15:12 raspberrypi3 volumio[937]: info: ------------------------------ 12ms Aug 31 09:15:12 raspberrypi3 volumio[937]: info: ------------------------------ 11ms Aug 31 09:15:12 raspberrypi3 volumio[937]: info: sendMpdCommand play took 9 milliseconds Aug 31 09:15:12 raspberrypi3 volumio[937]: info: ------------------------------ 7ms Aug 31 09:15:12 raspberrypi3 volumio[937]: info: ------------------------------ 6ms Aug 31 09:15:12 raspberrypi3 volumio[937]: info: Aug 31 09:15:12 raspberrypi3 volumio[937]: ---------------------------- MPD announces system playlist update Aug 31 09:15:12 raspberrypi3 volumio[937]: info: Ignoring MPD Status Update Aug 31 09:15:12 raspberrypi3 volumio[937]: info: Aug 31 09:15:12 raspberrypi3 volumio[937]: ---------------------------- MPD announces system playlist update Aug 31 09:15:12 raspberrypi3 volumio[937]: info: Ignoring MPD Status Update Aug 31 09:15:12 raspberrypi3 volumio[937]: error: Upnp client error: Error: This socket has been ended by the other party Aug 31 09:15:12 raspberrypi3 volumio[937]: info: ------------------------------ 6ms Aug 31 09:15:12 raspberrypi3 volumio[937]: info: ------------------------------ 4ms Aug 31 09:15:16 raspberrypi3 volumio[937]: info: Aug 31 09:15:16 raspberrypi3 volumio[937]: ---------------------------- MPD announces state update: player Aug 31 09:15:16 raspberrypi3 volumio[937]: info: ControllerMpd::getState Aug 31 09:15:16 raspberrypi3 volumio[937]: verbose: ControllerMpd::sendMpdCommand status Aug 31 09:15:16 raspberrypi3 volumio[937]: info: Aug 31 09:15:16 raspberrypi3 volumio[937]: ---------------------------- MPD announces state update: player Aug 31 09:15:16 raspberrypi3 volumio[937]: info: ControllerMpd::getState Aug 31 09:15:16 raspberrypi3 volumio[937]: verbose: ControllerMpd::sendMpdCommand status Aug 31 09:15:16 raspberrypi3 volumio[937]: info: Aug 31 09:15:16 raspberrypi3 volumio[937]: ---------------------------- MPD announces state update: player Aug 31 09:15:16 raspberrypi3 volumio[937]: info: ControllerMpd::getState Aug 31 09:15:16 raspberrypi3 volumio[937]: verbose: ControllerMpd::sendMpdCommand status Aug 31 09:15:16 raspberrypi3 volumio[937]: info: sendMpdCommand status took 21 milliseconds Aug 31 09:15:16 raspberrypi3 volumio[937]: verbose: ControllerMpd::parseState Aug 31 09:15:16 raspberrypi3 volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 09:15:16 raspberrypi3 volumio[937]: info: Aug 31 09:15:16 raspberrypi3 volumio[937]: ---------------------------- MPD announces state update: player Aug 31 09:15:16 raspberrypi3 volumio[937]: info: ControllerMpd::getState Aug 31 09:15:16 raspberrypi3 volumio[937]: verbose: ControllerMpd::sendMpdCommand status Aug 31 09:15:16 raspberrypi3 volumio[937]: info: sendMpdCommand status took 23 milliseconds Aug 31 09:15:16 raspberrypi3 volumio[937]: info: sendMpdCommand status took 21 milliseconds Aug 31 09:15:16 raspberrypi3 volumio[937]: info: sendMpdCommand playlistinfo took 3 milliseconds Aug 31 09:15:16 raspberrypi3 volumio[937]: verbose: ControllerMpd::parseState Aug 31 09:15:16 raspberrypi3 volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 09:15:16 raspberrypi3 volumio[937]: verbose: ControllerMpd::parseState Aug 31 09:15:16 raspberrypi3 volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 09:15:16 raspberrypi3 volumio[937]: verbose: ControllerMpd::parseTrackInfo Aug 31 09:15:16 raspberrypi3 volumio[937]: info: ControllerMpd::pushState Aug 31 09:15:16 raspberrypi3 volumio[937]: info: CoreCommandRouter::servicePushState Aug 31 09:15:16 raspberrypi3 volumio[937]: info: CorePlayQueue::getTrack 0 Aug 31 09:15:16 raspberrypi3 volumio[937]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":4520,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"127 Kbps","isStreaming":false,"title":"Best of TWO STEPS FROM HELL - TOP 25 TRACKS _ TSFH Vol 2.mp4","artist":null,"album":null,"uri":"USB/KIOXIA/Best of TWO STEPS FROM HELL - TOP 25 TRACKS _ TSFH Vol 2.mp4","trackType":"mp4"} Aug 31 09:15:16 raspberrypi3 volumio[937]: verbose: CURRENT POSITION 0 Aug 31 09:15:16 raspberrypi3 volumio[937]: info: CoreStateMachine::syncState stateService play Aug 31 09:15:16 raspberrypi3 volumio[937]: info: CoreStateMachine::syncState currentStatus stop Aug 31 09:15:16 raspberrypi3 volumio[937]: info: ------------------------------ 43ms Aug 31 09:15:16 raspberrypi3 volumio[937]: info: Aug 31 09:15:16 raspberrypi3 volumio[937]: ---------------------------- MPD announces state update: player Aug 31 09:15:16 raspberrypi3 volumio[937]: info: ControllerMpd::getState Aug 31 09:15:16 raspberrypi3 volumio[937]: verbose: ControllerMpd::sendMpdCommand status Aug 31 09:15:16 raspberrypi3 volumio[937]: info: Aug 31 09:15:16 raspberrypi3 volumio[937]: ---------------------------- MPD announces state update: player Aug 31 09:15:16 raspberrypi3 volumio[937]: info: ControllerMpd::getState Aug 31 09:15:16 raspberrypi3 volumio[937]: verbose: ControllerMpd::sendMpdCommand status Aug 31 09:15:16 raspberrypi3 volumio[937]: info: sendMpdCommand status took 22 milliseconds Aug 31 09:15:16 raspberrypi3 volumio[937]: info: sendMpdCommand playlistinfo took 19 milliseconds Aug 31 09:15:16 raspberrypi3 volumio[937]: info: sendMpdCommand playlistinfo took 19 milliseconds Aug 31 09:15:16 raspberrypi3 volumio[937]: info: sendMpdCommand status took 7 milliseconds Aug 31 09:15:16 raspberrypi3 volumio[937]: info: sendMpdCommand status took 4 milliseconds Aug 31 09:15:16 raspberrypi3 volumio[937]: verbose: ControllerMpd::parseState Aug 31 09:15:16 raspberrypi3 volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 09:15:16 raspberrypi3 volumio[937]: verbose: ControllerMpd::parseTrackInfo Aug 31 09:15:16 raspberrypi3 volumio[937]: verbose: ControllerMpd::parseTrackInfo Aug 31 09:15:16 raspberrypi3 volumio[937]: verbose: ControllerMpd::parseState Aug 31 09:15:16 raspberrypi3 volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 09:15:16 raspberrypi3 volumio[937]: verbose: ControllerMpd::parseState Aug 31 09:15:16 raspberrypi3 volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 09:15:16 raspberrypi3 volumio[937]: info: ControllerMpd::pushState Aug 31 09:15:16 raspberrypi3 volumio[937]: info: CoreCommandRouter::servicePushState Aug 31 09:15:16 raspberrypi3 volumio[937]: info: CorePlayQueue::getTrack 0 Aug 31 09:15:16 raspberrypi3 volumio[937]: verbose: STATE SERVICE {"status":"play","position":0,"seek":480,"duration":4520,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"127 Kbps","isStreaming":false,"title":"Best of TWO STEPS FROM HELL - TOP 25 TRACKS _ TSFH Vol 2.mp4","artist":null,"album":null,"uri":"USB/KIOXIA/Best of TWO STEPS FROM HELL - TOP 25 TRACKS _ TSFH Vol 2.mp4","trackType":"mp4"} Aug 31 09:15:16 raspberrypi3 volumio[937]: verbose: CURRENT POSITION 0 Aug 31 09:15:16 raspberrypi3 volumio[937]: info: CoreStateMachine::syncState stateService play Aug 31 09:15:16 raspberrypi3 volumio[937]: info: CoreStateMachine::syncState currentStatus play Aug 31 09:15:16 raspberrypi3 volumio[937]: info: Received an update from plugin. extracting info from payload Aug 31 09:15:16 raspberrypi3 volumio[937]: info: CoreStateMachine::pushState Aug 31 09:15:16 raspberrypi3 volumio[937]: info: CorePlayQueue::getTrack 0 Aug 31 09:15:16 raspberrypi3 volumio[937]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 09:15:16 raspberrypi3 volumio[937]: info: CoreCommandRouter::volumioPushState Aug 31 09:15:16 raspberrypi3 volumio[937]: info: CoreStateMachine::pushState Aug 31 09:15:16 raspberrypi3 volumio[937]: info: CorePlayQueue::getTrack 0 Aug 31 09:15:16 raspberrypi3 volumio[937]: info: CoreCommandRouter::volumioPushState Aug 31 09:15:16 raspberrypi3 volumio[937]: info: ControllerMpd::pushState Aug 31 09:15:16 raspberrypi3 volumio[937]: info: CoreCommandRouter::servicePushState Aug 31 09:15:16 raspberrypi3 volumio[937]: info: CorePlayQueue::getTrack 0 Aug 31 09:15:16 raspberrypi3 volumio[937]: verbose: STATE SERVICE {"status":"play","position":0,"seek":480,"duration":4520,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"127 Kbps","isStreaming":false,"title":"Best of TWO STEPS FROM HELL - TOP 25 TRACKS _ TSFH Vol 2.mp4","artist":null,"album":null,"uri":"USB/KIOXIA/Best of TWO STEPS FROM HELL - TOP 25 TRACKS _ TSFH Vol 2.mp4","trackType":"mp4"} Aug 31 09:15:16 raspberrypi3 volumio[937]: verbose: CURRENT POSITION 0 Aug 31 09:15:16 raspberrypi3 volumio[937]: info: CoreStateMachine::syncState stateService play Aug 31 09:15:16 raspberrypi3 volumio[937]: info: CoreStateMachine::syncState currentStatus play Aug 31 09:15:16 raspberrypi3 volumio[937]: info: Received an update from plugin. extracting info from payload Aug 31 09:15:16 raspberrypi3 volumio[937]: info: CoreStateMachine::pushState Aug 31 09:15:16 raspberrypi3 volumio[937]: info: CorePlayQueue::getTrack 0 Aug 31 09:15:16 raspberrypi3 volumio[937]: info: CoreCommandRouter::volumioPushState Aug 31 09:15:16 raspberrypi3 volumio[937]: info: CoreStateMachine::pushState Aug 31 09:15:16 raspberrypi3 volumio[937]: info: CorePlayQueue::getTrack 0 Aug 31 09:15:16 raspberrypi3 volumio[937]: info: CoreCommandRouter::volumioPushState Aug 31 09:15:16 raspberrypi3 volumio[937]: info: ------------------------------ 104ms Aug 31 09:15:16 raspberrypi3 volumio[937]: info: ------------------------------ 102ms Aug 31 09:15:16 raspberrypi3 volumio[937]: info: sendMpdCommand playlistinfo took 56 milliseconds Aug 31 09:15:16 raspberrypi3 volumio[937]: info: sendMpdCommand playlistinfo took 55 milliseconds Aug 31 09:15:16 raspberrypi3 volumio[937]: info: sendMpdCommand playlistinfo took 54 milliseconds Aug 31 09:15:16 raspberrypi3 volumio[937]: verbose: ControllerMpd::parseTrackInfo Aug 31 09:15:16 raspberrypi3 volumio[937]: verbose: ControllerMpd::parseTrackInfo Aug 31 09:15:16 raspberrypi3 volumio[937]: verbose: ControllerMpd::parseTrackInfo Aug 31 09:15:16 raspberrypi3 volumio[937]: info: ControllerMpd::pushState Aug 31 09:15:16 raspberrypi3 volumio[937]: info: CoreCommandRouter::servicePushState Aug 31 09:15:16 raspberrypi3 volumio[937]: info: CorePlayQueue::getTrack 0 Aug 31 09:15:16 raspberrypi3 volumio[937]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":4520,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"127 Kbps","isStreaming":false,"title":"Best of TWO STEPS FROM HELL - TOP 25 TRACKS _ TSFH Vol 2.mp4","artist":null,"album":null,"uri":"USB/KIOXIA/Best of TWO STEPS FROM HELL - TOP 25 TRACKS _ TSFH Vol 2.mp4","trackType":"mp4"} Aug 31 09:15:16 raspberrypi3 volumio[937]: verbose: CURRENT POSITION 0 Aug 31 09:15:16 raspberrypi3 volumio[937]: info: CoreStateMachine::syncState stateService play Aug 31 09:15:16 raspberrypi3 volumio[937]: info: CoreStateMachine::syncState currentStatus play Aug 31 09:15:16 raspberrypi3 volumio[937]: info: Received an update from plugin. extracting info from payload Aug 31 09:15:16 raspberrypi3 volumio[937]: info: CoreStateMachine::pushState Aug 31 09:15:16 raspberrypi3 volumio[937]: info: CorePlayQueue::getTrack 0 Aug 31 09:15:16 raspberrypi3 volumio[937]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 09:15:16 raspberrypi3 volumio[937]: info: CoreCommandRouter::volumioPushState Aug 31 09:15:16 raspberrypi3 volumio[937]: info: CoreStateMachine::pushState Aug 31 09:15:16 raspberrypi3 volumio[937]: info: CorePlayQueue::getTrack 0 Aug 31 09:15:16 raspberrypi3 volumio[937]: info: CoreCommandRouter::volumioPushState Aug 31 09:15:16 raspberrypi3 volumio[937]: info: ControllerMpd::pushState Aug 31 09:15:16 raspberrypi3 volumio[937]: info: CoreCommandRouter::servicePushState Aug 31 09:15:16 raspberrypi3 volumio[937]: info: CorePlayQueue::getTrack 0 Aug 31 09:15:16 raspberrypi3 volumio[937]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":4520,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"127 Kbps","isStreaming":false,"title":"Best of TWO STEPS FROM HELL - TOP 25 TRACKS _ TSFH Vol 2.mp4","artist":null,"album":null,"uri":"USB/KIOXIA/Best of TWO STEPS FROM HELL - TOP 25 TRACKS _ TSFH Vol 2.mp4","trackType":"mp4"} Aug 31 09:15:16 raspberrypi3 volumio[937]: verbose: CURRENT POSITION 0 Aug 31 09:15:16 raspberrypi3 volumio[937]: info: CoreStateMachine::syncState stateService play Aug 31 09:15:16 raspberrypi3 volumio[937]: info: CoreStateMachine::syncState currentStatus play Aug 31 09:15:16 raspberrypi3 volumio[937]: info: Received an update from plugin. extracting info from payload Aug 31 09:15:16 raspberrypi3 volumio[937]: info: CoreStateMachine::pushState Aug 31 09:15:16 raspberrypi3 volumio[937]: info: CorePlayQueue::getTrack 0 Aug 31 09:15:16 raspberrypi3 volumio[937]: info: CoreCommandRouter::volumioPushState Aug 31 09:15:16 raspberrypi3 volumio[937]: info: CoreStateMachine::pushState Aug 31 09:15:16 raspberrypi3 volumio[937]: info: CorePlayQueue::getTrack 0 Aug 31 09:15:16 raspberrypi3 volumio[937]: info: CoreCommandRouter::volumioPushState Aug 31 09:15:16 raspberrypi3 volumio[937]: info: ControllerMpd::pushState Aug 31 09:15:16 raspberrypi3 volumio[937]: info: CoreCommandRouter::servicePushState Aug 31 09:15:16 raspberrypi3 volumio[937]: info: CorePlayQueue::getTrack 0 Aug 31 09:15:16 raspberrypi3 volumio[937]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":4520,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"127 Kbps","isStreaming":false,"title":"Best of TWO STEPS FROM HELL - TOP 25 TRACKS _ TSFH Vol 2.mp4","artist":null,"album":null,"uri":"USB/KIOXIA/Best of TWO STEPS FROM HELL - TOP 25 TRACKS _ TSFH Vol 2.mp4","trackType":"mp4"} Aug 31 09:15:16 raspberrypi3 volumio[937]: verbose: CURRENT POSITION 0 Aug 31 09:15:16 raspberrypi3 volumio[937]: info: CoreStateMachine::syncState stateService play Aug 31 09:15:16 raspberrypi3 volumio[937]: info: CoreStateMachine::syncState currentStatus play Aug 31 09:15:16 raspberrypi3 volumio[937]: info: Received an update from plugin. extracting info from payload Aug 31 09:15:16 raspberrypi3 volumio[937]: info: CoreStateMachine::pushState Aug 31 09:15:16 raspberrypi3 volumio[937]: info: CorePlayQueue::getTrack 0 Aug 31 09:15:16 raspberrypi3 volumio[937]: info: CoreCommandRouter::volumioPushState Aug 31 09:15:16 raspberrypi3 volumio[937]: info: CoreStateMachine::pushState Aug 31 09:15:16 raspberrypi3 volumio[937]: info: CorePlayQueue::getTrack 0 Aug 31 09:15:16 raspberrypi3 volumio[937]: info: CoreCommandRouter::volumioPushState Aug 31 09:15:16 raspberrypi3 volumio[937]: info: ------------------------------ 170ms Aug 31 09:15:16 raspberrypi3 volumio[937]: info: ------------------------------ 155ms Aug 31 09:15:16 raspberrypi3 volumio[937]: info: ------------------------------ 153ms Aug 31 09:15:19 raspberrypi3 volumio[937]: info: VolumeController::SetAlsaVolume18 Aug 31 09:15:19 raspberrypi3 volumio[937]: info: CoreStateMachine::pushState Aug 31 09:15:19 raspberrypi3 volumio[937]: info: CorePlayQueue::getTrack 0 Aug 31 09:15:19 raspberrypi3 volumio[937]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 09:15:19 raspberrypi3 volumio[937]: info: CoreCommandRouter::volumioPushState Aug 31 09:15:20 raspberrypi3 volumio[937]: info: VolumeController::SetAlsaVolume24 Aug 31 09:15:20 raspberrypi3 volumio[937]: info: CoreStateMachine::pushState Aug 31 09:15:20 raspberrypi3 volumio[937]: info: CorePlayQueue::getTrack 0 Aug 31 09:15:20 raspberrypi3 volumio[937]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 09:15:20 raspberrypi3 volumio[937]: info: CoreCommandRouter::volumioPushState Aug 31 09:15:20 raspberrypi3 volumio[937]: info: VolumeController::SetAlsaVolume30 Aug 31 09:15:20 raspberrypi3 volumio[937]: info: CoreStateMachine::pushState Aug 31 09:15:20 raspberrypi3 volumio[937]: info: CorePlayQueue::getTrack 0 Aug 31 09:15:20 raspberrypi3 volumio[937]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 09:15:20 raspberrypi3 volumio[937]: info: CoreCommandRouter::volumioPushState Aug 31 09:15:22 raspberrypi3 volumio[937]: info: VolumeController::SetAlsaVolume25 Aug 31 09:15:22 raspberrypi3 volumio[937]: info: CoreStateMachine::pushState Aug 31 09:15:22 raspberrypi3 volumio[937]: info: CorePlayQueue::getTrack 0 Aug 31 09:15:22 raspberrypi3 volumio[937]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 09:15:22 raspberrypi3 volumio[937]: info: CoreCommandRouter::volumioPushState Aug 31 09:15:29 raspberrypi3 volumio[937]: info: CoreCommandRouter::volumioPause Aug 31 09:15:29 raspberrypi3 volumio[937]: info: CoreStateMachine::pause Aug 31 09:15:29 raspberrypi3 volumio[937]: info: CoreStateMachine::stPlaybackTimer Aug 31 09:15:29 raspberrypi3 volumio[937]: info: CoreStateMachine::servicePause Aug 31 09:15:29 raspberrypi3 volumio[937]: info: CorePlayQueue::getTrack 0 Aug 31 09:15:29 raspberrypi3 volumio[937]: info: CoreCommandRouter::servicePause Aug 31 09:15:29 raspberrypi3 volumio[937]: info: ControllerMpd::pause Aug 31 09:15:29 raspberrypi3 volumio[937]: verbose: ControllerMpd::sendMpdCommand pause Aug 31 09:15:29 raspberrypi3 volumio[937]: info: Aug 31 09:15:29 raspberrypi3 volumio[937]: ---------------------------- MPD announces state update: player Aug 31 09:15:29 raspberrypi3 volumio[937]: info: sendMpdCommand pause took 2 milliseconds Aug 31 09:15:29 raspberrypi3 volumio[937]: info: ControllerMpd::getState Aug 31 09:15:29 raspberrypi3 volumio[937]: verbose: ControllerMpd::sendMpdCommand status Aug 31 09:15:29 raspberrypi3 volumio[937]: info: Aug 31 09:15:29 raspberrypi3 volumio[937]: ---------------------------- MPD announces state update: player Aug 31 09:15:29 raspberrypi3 volumio[937]: info: ControllerMpd::getState Aug 31 09:15:29 raspberrypi3 volumio[937]: verbose: ControllerMpd::sendMpdCommand status Aug 31 09:15:29 raspberrypi3 volumio[937]: info: Aug 31 09:15:29 raspberrypi3 volumio[937]: ---------------------------- MPD announces state update: player Aug 31 09:15:29 raspberrypi3 volumio[937]: info: ControllerMpd::getState Aug 31 09:15:29 raspberrypi3 volumio[937]: verbose: ControllerMpd::sendMpdCommand status Aug 31 09:15:29 raspberrypi3 volumio[937]: info: sendMpdCommand status took 6 milliseconds Aug 31 09:15:29 raspberrypi3 volumio[937]: info: sendMpdCommand status took 3 milliseconds Aug 31 09:15:29 raspberrypi3 volumio[937]: info: sendMpdCommand status took 2 milliseconds Aug 31 09:15:29 raspberrypi3 volumio[937]: verbose: ControllerMpd::parseState Aug 31 09:15:29 raspberrypi3 volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 09:15:29 raspberrypi3 volumio[937]: verbose: ControllerMpd::parseState Aug 31 09:15:29 raspberrypi3 volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 09:15:29 raspberrypi3 volumio[937]: verbose: ControllerMpd::parseState Aug 31 09:15:29 raspberrypi3 volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 09:15:29 raspberrypi3 volumio[937]: info: sendMpdCommand playlistinfo took 3 milliseconds Aug 31 09:15:29 raspberrypi3 volumio[937]: info: sendMpdCommand playlistinfo took 3 milliseconds Aug 31 09:15:29 raspberrypi3 volumio[937]: info: sendMpdCommand playlistinfo took 3 milliseconds Aug 31 09:15:29 raspberrypi3 volumio[937]: verbose: ControllerMpd::parseTrackInfo Aug 31 09:15:29 raspberrypi3 volumio[937]: verbose: ControllerMpd::parseTrackInfo Aug 31 09:15:29 raspberrypi3 volumio[937]: verbose: ControllerMpd::parseTrackInfo Aug 31 09:15:29 raspberrypi3 volumio[937]: info: ControllerMpd::pushState Aug 31 09:15:29 raspberrypi3 volumio[937]: info: CoreCommandRouter::servicePushState Aug 31 09:15:29 raspberrypi3 volumio[937]: info: CorePlayQueue::getTrack 0 Aug 31 09:15:29 raspberrypi3 volumio[937]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":13680,"duration":4520,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"127 Kbps","isStreaming":false,"title":"Best of TWO STEPS FROM HELL - TOP 25 TRACKS _ TSFH Vol 2.mp4","artist":null,"album":null,"uri":"USB/KIOXIA/Best of TWO STEPS FROM HELL - TOP 25 TRACKS _ TSFH Vol 2.mp4","trackType":"mp4"} Aug 31 09:15:29 raspberrypi3 volumio[937]: verbose: CURRENT POSITION 0 Aug 31 09:15:29 raspberrypi3 volumio[937]: info: CoreStateMachine::syncState stateService pause Aug 31 09:15:29 raspberrypi3 volumio[937]: info: CoreStateMachine::syncState currentStatus pause Aug 31 09:15:29 raspberrypi3 volumio[937]: info: CoreStateMachine::pushState Aug 31 09:15:29 raspberrypi3 volumio[937]: info: CorePlayQueue::getTrack 0 Aug 31 09:15:29 raspberrypi3 volumio[937]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 09:15:29 raspberrypi3 volumio[937]: info: CoreCommandRouter::volumioPushState Aug 31 09:15:29 raspberrypi3 volumio[937]: info: CoreStateMachine::stPlaybackTimer Aug 31 09:15:29 raspberrypi3 volumio[937]: info: ControllerMpd::pushState Aug 31 09:15:29 raspberrypi3 volumio[937]: info: CoreCommandRouter::servicePushState Aug 31 09:15:29 raspberrypi3 volumio[937]: info: CorePlayQueue::getTrack 0 Aug 31 09:15:29 raspberrypi3 volumio[937]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":13680,"duration":4520,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"127 Kbps","isStreaming":false,"title":"Best of TWO STEPS FROM HELL - TOP 25 TRACKS _ TSFH Vol 2.mp4","artist":null,"album":null,"uri":"USB/KIOXIA/Best of TWO STEPS FROM HELL - TOP 25 TRACKS _ TSFH Vol 2.mp4","trackType":"mp4"} Aug 31 09:15:29 raspberrypi3 volumio[937]: verbose: CURRENT POSITION 0 Aug 31 09:15:29 raspberrypi3 volumio[937]: info: CoreStateMachine::syncState stateService pause Aug 31 09:15:29 raspberrypi3 volumio[937]: info: CoreStateMachine::syncState currentStatus pause Aug 31 09:15:29 raspberrypi3 volumio[937]: info: CoreStateMachine::pushState Aug 31 09:15:29 raspberrypi3 volumio[937]: info: CorePlayQueue::getTrack 0 Aug 31 09:15:29 raspberrypi3 volumio[937]: info: CoreCommandRouter::volumioPushState Aug 31 09:15:29 raspberrypi3 volumio[937]: info: CoreStateMachine::stPlaybackTimer Aug 31 09:15:29 raspberrypi3 volumio[937]: info: ControllerMpd::pushState Aug 31 09:15:29 raspberrypi3 volumio[937]: info: CoreCommandRouter::servicePushState Aug 31 09:15:29 raspberrypi3 volumio[937]: info: CorePlayQueue::getTrack 0 Aug 31 09:15:29 raspberrypi3 volumio[937]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":13680,"duration":4520,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"127 Kbps","isStreaming":false,"title":"Best of TWO STEPS FROM HELL - TOP 25 TRACKS _ TSFH Vol 2.mp4","artist":null,"album":null,"uri":"USB/KIOXIA/Best of TWO STEPS FROM HELL - TOP 25 TRACKS _ TSFH Vol 2.mp4","trackType":"mp4"} Aug 31 09:15:29 raspberrypi3 volumio[937]: verbose: CURRENT POSITION 0 Aug 31 09:15:29 raspberrypi3 volumio[937]: info: CoreStateMachine::syncState stateService pause Aug 31 09:15:29 raspberrypi3 volumio[937]: info: CoreStateMachine::syncState currentStatus pause Aug 31 09:15:29 raspberrypi3 volumio[937]: info: CoreStateMachine::pushState Aug 31 09:15:29 raspberrypi3 volumio[937]: info: CorePlayQueue::getTrack 0 Aug 31 09:15:29 raspberrypi3 volumio[937]: info: CoreCommandRouter::volumioPushState Aug 31 09:15:29 raspberrypi3 volumio[937]: info: CoreStateMachine::stPlaybackTimer Aug 31 09:15:29 raspberrypi3 volumio[937]: info: ------------------------------ 55ms Aug 31 09:15:29 raspberrypi3 volumio[937]: info: ------------------------------ 53ms Aug 31 09:15:29 raspberrypi3 volumio[937]: info: ------------------------------ 53ms Aug 31 09:15:38 raspberrypi3 volumio[937]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:15:38 raspberrypi3 volumio[937]: info: CoreStateMachine::getQueue Aug 31 09:15:38 raspberrypi3 volumio[937]: info: CorePlayQueue::getQueue Aug 31 09:15:43 raspberrypi3 volumio[937]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 31 09:15:43 raspberrypi3 volumio[937]: info: CURURI: music-library Aug 31 09:15:43 raspberrypi3 volumio[937]: info: Preload queue cleared Aug 31 09:15:49 raspberrypi3 volumio[937]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 31 09:15:49 raspberrypi3 volumio[937]: info: CURURI: music-library/USB Aug 31 09:15:49 raspberrypi3 volumio[937]: info: Preload queue cleared Aug 31 09:16:10 raspberrypi3 volumio[937]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 31 09:16:10 raspberrypi3 volumio[937]: info: CURURI: music-library/USB/KIOXIA Aug 31 09:16:10 raspberrypi3 volumio[937]: info: Preload queue cleared Aug 31 09:16:10 raspberrypi3 volumio[937]: info: Preloading song: music-library/USB/KIOXIA/Best of TWO STEPS FROM HELL - TOP 25 TRACKS _ TSFH Vol 2.mp4 Aug 31 09:16:10 raspberrypi3 volumio[937]: info: Preloading song: music-library/USB/KIOXIA/Best of TWO STEPS FROM HELL - TOP 25 TRACKS _ TSFH Vol 3.mp4 Aug 31 09:16:10 raspberrypi3 volumio[937]: info: Preloading song: music-library/USB/KIOXIA/Best of TWO STEPS FROM HELL - TOP 50 TRACKS _ TSFH Vol 1.mp4 Aug 31 09:16:10 raspberrypi3 volumio[937]: info: Exploding uri music-library/USB/KIOXIA/Best of TWO STEPS FROM HELL - TOP 25 TRACKS _ TSFH Vol 2.mp4 in service mpd Aug 31 09:16:10 raspberrypi3 volumio[937]: info: ALBUMART /albumart?cacheid=88&web=//extralarge&path=%2Fmnt%2FUSB%2FKIOXIA%2FBest%20of%20TWO%20STEPS%20FROM%20HELL%20-%20TOP%2025%20TRACKS%20_%20TSFH%20Vol%202.mp4&metadata=false Aug 31 09:16:10 raspberrypi3 volumio[937]: info: URI /mnt/USB/KIOXIA/Best of TWO STEPS FROM HELL - TOP 25 TRACKS _ TSFH Vol 2.mp4 Aug 31 09:16:10 raspberrypi3 volumio[937]: info: Exploding uri music-library/USB/KIOXIA/Best of TWO STEPS FROM HELL - TOP 25 TRACKS _ TSFH Vol 3.mp4 in service mpd Aug 31 09:16:10 raspberrypi3 volumio[937]: info: ALBUMART /albumart?cacheid=88&web=//extralarge&path=%2Fmnt%2FUSB%2FKIOXIA%2FBest%20of%20TWO%20STEPS%20FROM%20HELL%20-%20TOP%2025%20TRACKS%20_%20TSFH%20Vol%203.mp4&metadata=false Aug 31 09:16:10 raspberrypi3 volumio[937]: info: URI /mnt/USB/KIOXIA/Best of TWO STEPS FROM HELL - TOP 25 TRACKS _ TSFH Vol 3.mp4 Aug 31 09:16:10 raspberrypi3 volumio[937]: info: Exploding uri music-library/USB/KIOXIA/Best of TWO STEPS FROM HELL - TOP 50 TRACKS _ TSFH Vol 1.mp4 in service mpd Aug 31 09:16:10 raspberrypi3 volumio[937]: info: ALBUMART /albumart?cacheid=88&web=//extralarge&path=%2Fmnt%2FUSB%2FKIOXIA%2FBest%20of%20TWO%20STEPS%20FROM%20HELL%20-%20TOP%2050%20TRACKS%20_%20TSFH%20Vol%201.mp4&metadata=false Aug 31 09:16:10 raspberrypi3 volumio[937]: info: URI /mnt/USB/KIOXIA/Best of TWO STEPS FROM HELL - TOP 50 TRACKS _ TSFH Vol 1.mp4 Aug 31 09:16:16 raspberrypi3 volumio[937]: info: CoreCommandRouter::volumioGetState Aug 31 09:16:16 raspberrypi3 volumio[937]: info: CorePlayQueue::getTrack 0 Aug 31 09:16:21 raspberrypi3 volumio[937]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 31 09:16:21 raspberrypi3 volumio[937]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 31 09:16:21 raspberrypi3 volumio[937]: info: Retrieving Cloud Streaming UI Aug 31 09:16:21 raspberrypi3 volumio[937]: info: Getting Tidal Cloud Configuration Aug 31 09:16:21 raspberrypi3 volumio[937]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 31 09:16:21 raspberrypi3 volumio[937]: info: Getting Qobuz Cloud Configuration Aug 31 09:16:21 raspberrypi3 volumio[937]: info: Asking plugin for UI Config Aug 31 09:16:21 raspberrypi3 volumio[937]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 31 09:16:21 raspberrypi3 volumio[937]: info: Getting Spotify Cloud Configuration Aug 31 09:16:21 raspberrypi3 volumio[937]: info: Asking plugin for UI Config Aug 31 09:16:21 raspberrypi3 volumio[937]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 31 09:16:21 raspberrypi3 volumio[937]: info: Saving Spotify Acccount Aug 31 09:16:21 raspberrypi3 volumio[937]: info: Got Tidal Cloud Configuration Aug 31 09:16:21 raspberrypi3 volumio[937]: info: Got it Aug 31 09:16:21 raspberrypi3 volumio[937]: info: Got it Aug 31 09:16:21 raspberrypi3 volumio[937]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Aug 31 09:16:21 raspberrypi3 volumio[937]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 31 09:16:21 raspberrypi3 volumio[937]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Aug 31 09:16:21 raspberrypi3 volumio[937]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 31 09:16:21 raspberrypi3 volumio[937]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Aug 31 09:16:21 raspberrypi3 volumio[937]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Aug 31 09:16:21 raspberrypi3 volumio[937]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Aug 31 09:16:21 raspberrypi3 volumio[937]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 09:16:21 raspberrypi3 volumio[937]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 09:16:21 raspberrypi3 volumio[937]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 09:16:21 raspberrypi3 volumio[937]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 09:16:21 raspberrypi3 volumio[937]: info: CoreCommandRouter::volumioGetBrowseSources Aug 31 09:16:21 raspberrypi3 volumio[937]: info: CoreCommandRouter::volumioGetBrowseSources Aug 31 09:16:21 raspberrypi3 volumio[937]: info: CoreCommandRouter::volumioGetBrowseSources Aug 31 09:16:21 raspberrypi3 volumio[937]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 31 09:16:21 raspberrypi3 volumio[937]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Aug 31 09:16:25 raspberrypi3 volumio[937]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 31 09:16:27 raspberrypi3 volumio[937]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Aug 31 09:16:27 raspberrypi3 volumio[937]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Aug 31 09:16:28 raspberrypi3 volumio[937]: info: Executing SMB command: smbclient --no-pass --debuglevel=0 -L volumio-tinker.local. -m SMB3_11 Aug 31 09:16:29 raspberrypi3 volumio[937]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 31 09:16:32 raspberrypi3 volumio[937]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 31 09:16:32 raspberrypi3 volumio[937]: Error: dns service error: unknown Aug 31 09:16:32 raspberrypi3 volumio[937]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30) Aug 31 09:16:32 raspberrypi3 volumio[937]: at SocketWatcher.MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Aug 31 09:16:32 raspberrypi3 volumio[937]: errorCode: -65537 Aug 31 09:16:32 raspberrypi3 volumio[937]: } Aug 31 09:16:32 raspberrypi3 volumio[937]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 31 09:16:32 raspberrypi3 sudo[1935]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-08-31 09:15 Aug 31 09:16:32 raspberrypi3 sudo[1935]: 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"