-- Logs begin at Thu 2019-02-14 18:11:59 CST, end at Fri 2025-05-23 19:11:17 CST. -- May 23 19:10:25 smsl-n100 nmbd[786]: [2025/05/23 19:10:25.092144, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) May 23 19:10:25 smsl-n100 nmbd[786]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.31.160 for name WORKGROUP<1d>. May 23 19:10:25 smsl-n100 nmbd[786]: This response was from IP 192.168.31.136, reporting an IP address of 192.168.31.136. May 23 19:10:30 smsl-n100 volumio[14993]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 23 19:10:30 smsl-n100 volumio[14993]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 23 19:10:30 smsl-n100 volumio[14993]: info: Discovery: Getting this device information May 23 19:10:30 smsl-n100 volumio[14993]: info: CoreCommandRouter::volumioGetState May 23 19:10:30 smsl-n100 volumio[14993]: info: CorePlayQueue::getTrack 0 May 23 19:10:30 smsl-n100 volumio[14993]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 23 19:10:36 smsl-n100 volumio[14993]: info: Preload queue cleared May 23 19:10:36 smsl-n100 volumio[14993]: info: CoreCommandRouter::volumioReplaceandPlayItems May 23 19:10:36 smsl-n100 volumio[14993]: info: CoreStateMachine::ClearQueue May 23 19:10:36 smsl-n100 volumio[14993]: info: CoreStateMachine::stop May 23 19:10:36 smsl-n100 volumio[14993]: info: CoreStateMachine::setConsumeUpdateService undefined May 23 19:10:36 smsl-n100 volumio[14993]: info: CoreStateMachine::stPlaybackTimer May 23 19:10:36 smsl-n100 volumio[14993]: info: CoreStateMachine::updateTrackBlock May 23 19:10:36 smsl-n100 volumio[14993]: info: CorePlayQueue::getTrackBlock May 23 19:10:36 smsl-n100 volumio[14993]: info: CoreStateMachine::pushState May 23 19:10:36 smsl-n100 volumio[14993]: info: CorePlayQueue::getTrack 0 May 23 19:10:36 smsl-n100 volumio[14993]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 23 19:10:36 smsl-n100 volumio[14993]: info: CoreCommandRouter::volumioPushState May 23 19:10:36 smsl-n100 volumio[14993]: info: MRS: Pushing multiroomSync output update for this device May 23 19:10:36 smsl-n100 volumio[14993]: info: MRS: Pushing multiroomSync output May 23 19:10:36 smsl-n100 volumio[14993]: info: CoreStateMachine::serviceStop May 23 19:10:36 smsl-n100 volumio[14993]: info: CorePlayQueue::getTrack 0 May 23 19:10:36 smsl-n100 volumio[14993]: info: CoreCommandRouter::serviceStop May 23 19:10:36 smsl-n100 volumio[14993]: info: ControllerMpd::stop May 23 19:10:36 smsl-n100 volumio[14993]: verbose: ControllerMpd::sendMpdCommand stop May 23 19:10:36 smsl-n100 volumio[14993]: info: CorePlayQueue::clearPlayQueue May 23 19:10:36 smsl-n100 volumio[14993]: info: CorePlayQueue::saveQueue May 23 19:10:36 smsl-n100 volumio[14993]: info: CoreCommandRouter::volumioPushQueue May 23 19:10:36 smsl-n100 volumio[14993]: info: CoreStateMachine::addQueueItems May 23 19:10:36 smsl-n100 volumio[14993]: info: CorePlayQueue::addQueueItems May 23 19:10:36 smsl-n100 volumio[14993]: info: Preload queue cleared May 23 19:10:36 smsl-n100 volumio[14993]: info: Adding Item to queue: cdaudio/track0 May 23 19:10:36 smsl-n100 volumio[14993]: info: Exploding uri cdaudio/track0 in service cd_controller May 23 19:10:36 smsl-n100 volumio[14993]: info: Adding Item to queue: cdaudio/track1 May 23 19:10:36 smsl-n100 volumio[14993]: info: Exploding uri cdaudio/track1 in service cd_controller May 23 19:10:36 smsl-n100 volumio[14993]: info: Adding Item to queue: cdaudio/track2 May 23 19:10:36 smsl-n100 volumio[14993]: info: Exploding uri cdaudio/track2 in service cd_controller May 23 19:10:36 smsl-n100 volumio[14993]: info: Updating RAAT Signal Path May 23 19:10:36 smsl-n100 volumio[14993]: info: CoreCommandRouter::volumioPushQueue May 23 19:10:36 smsl-n100 volumio[14993]: info: CorePlayQueue::saveQueue May 23 19:10:36 smsl-n100 volumio[14993]: info: CoreStateMachine::updateTrackBlock May 23 19:10:36 smsl-n100 volumio[14993]: info: CorePlayQueue::getTrackBlock May 23 19:10:36 smsl-n100 volumio[14993]: info: CoreCommandRouter::volumioPlay May 23 19:10:36 smsl-n100 volumio[14993]: info: CoreStateMachine::play index 2 May 23 19:10:36 smsl-n100 volumio[14993]: info: CoreStateMachine::setConsumeUpdateService undefined May 23 19:10:36 smsl-n100 volumio[14993]: info: CoreStateMachine::addQueueItems May 23 19:10:36 smsl-n100 volumio[14993]: info: CorePlayQueue::addQueueItems May 23 19:10:36 smsl-n100 volumio[14993]: info: Preload queue cleared May 23 19:10:36 smsl-n100 volumio[14993]: info: Adding Item to queue: cdaudio/track3 May 23 19:10:36 smsl-n100 volumio[14993]: info: Exploding uri cdaudio/track3 in service cd_controller May 23 19:10:36 smsl-n100 volumio[14993]: info: Adding Item to queue: cdaudio/track4 May 23 19:10:36 smsl-n100 volumio[14993]: info: Exploding uri cdaudio/track4 in service cd_controller May 23 19:10:36 smsl-n100 volumio[14993]: info: Adding Item to queue: cdaudio/track5 May 23 19:10:36 smsl-n100 volumio[14993]: info: Exploding uri cdaudio/track5 in service cd_controller May 23 19:10:36 smsl-n100 volumio[14993]: info: Adding Item to queue: cdaudio/track6 May 23 19:10:36 smsl-n100 volumio[14993]: info: Exploding uri cdaudio/track6 in service cd_controller May 23 19:10:36 smsl-n100 volumio[14993]: info: Adding Item to queue: cdaudio/track7 May 23 19:10:36 smsl-n100 volumio[14993]: info: Exploding uri cdaudio/track7 in service cd_controller May 23 19:10:36 smsl-n100 volumio[14993]: info: Adding Item to queue: cdaudio/track8 May 23 19:10:36 smsl-n100 volumio[14993]: info: Exploding uri cdaudio/track8 in service cd_controller May 23 19:10:36 smsl-n100 volumio[14993]: info: Adding Item to queue: cdaudio/track9 May 23 19:10:36 smsl-n100 volumio[14993]: info: Exploding uri cdaudio/track9 in service cd_controller May 23 19:10:36 smsl-n100 volumio[14993]: info: Adding Item to queue: cdaudio/track10 May 23 19:10:36 smsl-n100 volumio[14993]: info: Exploding uri cdaudio/track10 in service cd_controller May 23 19:10:36 smsl-n100 volumio[14993]: info: CoreStateMachine::stop May 23 19:10:36 smsl-n100 volumio[14993]: info: CoreStateMachine::setConsumeUpdateService undefined May 23 19:10:36 smsl-n100 volumio[14993]: info: CoreStateMachine::play index undefined May 23 19:10:36 smsl-n100 volumio[14993]: info: CoreStateMachine::setConsumeUpdateService undefined May 23 19:10:36 smsl-n100 volumio[14993]: info: CorePlayQueue::getTrack 2 May 23 19:10:36 smsl-n100 volumio[14993]: info: CoreStateMachine::startPlaybackTimer May 23 19:10:36 smsl-n100 volumio[14993]: info: CorePlayQueue::getTrack 2 May 23 19:10:36 smsl-n100 volumio[14993]: info: CoreCommandRouter::volumioGetVisibleSources May 23 19:10:36 smsl-n100 volumio[14993]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 23 19:10:36 smsl-n100 volumio[14993]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject May 23 19:10:36 smsl-n100 volumio[14993]: verbose: ControllerMpd::clearAddPlayTracks cdda:///3 May 23 19:10:36 smsl-n100 volumio[14993]: verbose: ControllerMpd::sendMpdCommand stop May 23 19:10:36 smsl-n100 volumio[14993]: info: CoreStateMachine::pushState May 23 19:10:36 smsl-n100 volumio[14993]: info: CorePlayQueue::getTrack 2 May 23 19:10:36 smsl-n100 volumio[14993]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 23 19:10:36 smsl-n100 volumio[14993]: info: CoreCommandRouter::volumioPushState May 23 19:10:36 smsl-n100 volumio[14993]: info: MRS: Pushing multiroomSync output update for this device May 23 19:10:36 smsl-n100 volumio[14993]: info: MRS: Pushing multiroomSync output May 23 19:10:36 smsl-n100 volumio[14993]: error: Serial API: Failed to decode command: 100, message: undefined May 23 19:10:36 smsl-n100 volumio[14993]: error: Serial API: Failed to decode command: MAXVOL, message: May 23 19:10:36 smsl-n100 volumio[14993]: error: Serial API: Failed to decode command: 100, message: undefined May 23 19:10:36 smsl-n100 volumio[14993]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff May 23 19:10:36 smsl-n100 volumio[14993]: info: CoreCommandRouter::volumioPushQueue May 23 19:10:36 smsl-n100 volumio[14993]: info: CorePlayQueue::saveQueue May 23 19:10:36 smsl-n100 volumio[14993]: info: CoreStateMachine::updateTrackBlock May 23 19:10:36 smsl-n100 volumio[14993]: info: CorePlayQueue::getTrackBlock May 23 19:10:36 smsl-n100 volumio[14993]: info: VolumeController::SetAlsaVolume0 May 23 19:10:36 smsl-n100 volumio[14993]: info: CoreStateMachine::pushState May 23 19:10:36 smsl-n100 volumio[14993]: info: CorePlayQueue::getTrack 2 May 23 19:10:36 smsl-n100 volumio[14993]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 23 19:10:36 smsl-n100 volumio[14993]: info: CoreCommandRouter::volumioPushState May 23 19:10:36 smsl-n100 volumio[14993]: info: MRS: Pushing multiroomSync output update for this device May 23 19:10:36 smsl-n100 volumio[14993]: info: MRS: Pushing multiroomSync output May 23 19:10:36 smsl-n100 volumio[14993]: info: Updating RAAT Signal Path May 23 19:10:36 smsl-n100 volumio[14993]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Saybia/These%20Are%20the%20Days/87bdaf05-a41a-40ee-8bd9-6b1cb443c19d.jpg' May 23 19:10:36 smsl-n100 volumio[14993]: info: sendMpdCommand stop took 508 milliseconds May 23 19:10:36 smsl-n100 volumio[14993]: info: May 23 19:10:36 smsl-n100 volumio[14993]: ---------------------------- MPD announces state update: player May 23 19:10:36 smsl-n100 volumio[14993]: info: ControllerMpd::getState May 23 19:10:36 smsl-n100 volumio[14993]: verbose: ControllerMpd::sendMpdCommand status May 23 19:10:36 smsl-n100 volumio[14993]: info: sendMpdCommand stop took 374 milliseconds May 23 19:10:36 smsl-n100 volumio[14993]: verbose: ControllerMpd::sendMpdCommand clear May 23 19:10:36 smsl-n100 volumio[14993]: info: May 23 19:10:36 smsl-n100 volumio[14993]: ---------------------------- MPD announces state update: player May 23 19:10:36 smsl-n100 volumio[14993]: info: ControllerMpd::getState May 23 19:10:36 smsl-n100 volumio[14993]: verbose: ControllerMpd::sendMpdCommand status May 23 19:10:36 smsl-n100 volumio[14993]: info: May 23 19:10:36 smsl-n100 volumio[14993]: ---------------------------- MPD announces system playlist update May 23 19:10:36 smsl-n100 volumio[14993]: info: Ignoring MPD Status Update May 23 19:10:36 smsl-n100 volumio[14993]: info: sendMpdCommand status took 13 milliseconds May 23 19:10:36 smsl-n100 volumio[14993]: info: sendMpdCommand clear took 15 milliseconds May 23 19:10:36 smsl-n100 volumio[14993]: info: sendMpdCommand status took 20 milliseconds May 23 19:10:36 smsl-n100 volumio[14993]: verbose: ControllerMpd::parseState May 23 19:10:36 smsl-n100 volumio[14993]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 23 19:10:36 smsl-n100 volumio[14993]: verbose: ControllerMpd::sendMpdCommand add "cdda:///3" May 23 19:10:36 smsl-n100 volumio[14993]: verbose: ControllerMpd::parseState May 23 19:10:36 smsl-n100 volumio[14993]: info: ControllerMpd::pushState May 23 19:10:36 smsl-n100 volumio[14993]: info: CoreCommandRouter::servicePushState May 23 19:10:36 smsl-n100 volumio[14993]: info: CoreStateMachine::pushState May 23 19:10:36 smsl-n100 volumio[14993]: info: CorePlayQueue::getTrack 2 May 23 19:10:36 smsl-n100 volumio[14993]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 23 19:10:36 smsl-n100 volumio[14993]: info: CoreCommandRouter::volumioPushState May 23 19:10:36 smsl-n100 volumio[14993]: info: MRS: Pushing multiroomSync output update for this device May 23 19:10:36 smsl-n100 volumio[14993]: info: MRS: Pushing multiroomSync output May 23 19:10:36 smsl-n100 volumio[14993]: info: CorePlayQueue::getTrack 2 May 23 19:10:36 smsl-n100 volumio[14993]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 23 19:10:36 smsl-n100 volumio[14993]: verbose: CURRENT POSITION 2 May 23 19:10:36 smsl-n100 volumio[14993]: info: CoreStateMachine::syncState stateService stop May 23 19:10:36 smsl-n100 volumio[14993]: info: CoreStateMachine::syncState currentStatus stop May 23 19:10:36 smsl-n100 volumio[14993]: info: CoreStateMachine::pushState May 23 19:10:36 smsl-n100 volumio[14993]: info: CorePlayQueue::getTrack 2 May 23 19:10:36 smsl-n100 volumio[14993]: info: CoreCommandRouter::volumioPushState May 23 19:10:36 smsl-n100 volumio[14993]: info: MRS: Pushing multiroomSync output update for this device May 23 19:10:36 smsl-n100 volumio[14993]: info: MRS: Pushing multiroomSync output May 23 19:10:36 smsl-n100 volumio[14993]: info: No code May 23 19:10:36 smsl-n100 volumio[14993]: info: CoreStateMachine::pushState May 23 19:10:36 smsl-n100 volumio[14993]: info: CorePlayQueue::getTrack 2 May 23 19:10:36 smsl-n100 volumio[14993]: info: CoreCommandRouter::volumioPushState May 23 19:10:36 smsl-n100 volumio[14993]: info: MRS: Pushing multiroomSync output update for this device May 23 19:10:36 smsl-n100 volumio[14993]: info: MRS: Pushing multiroomSync output May 23 19:10:37 smsl-n100 volumio[14993]: info: ------------------------------ 119ms May 23 19:10:37 smsl-n100 volumio[14993]: info: May 23 19:10:37 smsl-n100 volumio[14993]: ---------------------------- MPD announces system playlist update May 23 19:10:37 smsl-n100 volumio[14993]: info: Ignoring MPD Status Update May 23 19:10:37 smsl-n100 volumio[14993]: error: updateQueue error: null May 23 19:10:37 smsl-n100 volumio[14993]: info: May 23 19:10:37 smsl-n100 volumio[14993]: ---------------------------- MPD announces system playlist update May 23 19:10:37 smsl-n100 volumio[14993]: info: Ignoring MPD Status Update May 23 19:10:37 smsl-n100 volumio[14993]: info: ------------------------------ 122ms May 23 19:10:37 smsl-n100 volumio[14993]: info: sendMpdCommand playlistinfo took 103 milliseconds May 23 19:10:37 smsl-n100 volumio[14993]: info: sendMpdCommand add "cdda:///3" took 102 milliseconds May 23 19:10:37 smsl-n100 volumio[14993]: info: ------------------------------ 9ms May 23 19:10:37 smsl-n100 volumio[14993]: verbose: ControllerMpd::parseTrackInfo May 23 19:10:37 smsl-n100 volumio[14993]: verbose: ControllerMpd::sendMpdCommand play May 23 19:10:37 smsl-n100 volumio[14993]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 23 19:10:37 smsl-n100 volumio[14993]: info: ------------------------------ 144ms May 23 19:10:37 smsl-n100 volumio[14993]: info: May 23 19:10:37 smsl-n100 volumio[14993]: ---------------------------- MPD announces system playlist update May 23 19:10:37 smsl-n100 volumio[14993]: info: Ignoring MPD Status Update May 23 19:10:37 smsl-n100 volumio[14993]: info: Updating RAAT Signal Path May 23 19:10:37 smsl-n100 volumio[14993]: info: Updating RAAT Signal Path May 23 19:10:37 smsl-n100 volumio[14993]: info: Updating RAAT Signal Path May 23 19:10:37 smsl-n100 volumio[14993]: info: ------------------------------ 61ms May 23 19:10:37 smsl-n100 volumio[14993]: info: sendMpdCommand play took 53 milliseconds May 23 19:10:37 smsl-n100 volumio[14993]: info: ------------------------------ 49ms May 23 19:10:37 smsl-n100 volumio[14993]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Saybia/These%20Are%20the%20Days/87bdaf05-a41a-40ee-8bd9-6b1cb443c19d.jpg' May 23 19:10:39 smsl-n100 volumio[14993]: info: May 23 19:10:39 smsl-n100 volumio[14993]: ---------------------------- MPD announces state update: player May 23 19:10:39 smsl-n100 volumio[14993]: info: ControllerMpd::getState May 23 19:10:39 smsl-n100 volumio[14993]: verbose: ControllerMpd::sendMpdCommand status May 23 19:10:39 smsl-n100 volumio[14993]: info: May 23 19:10:39 smsl-n100 volumio[14993]: ---------------------------- MPD announces state update: player May 23 19:10:39 smsl-n100 volumio[14993]: info: ControllerMpd::getState May 23 19:10:39 smsl-n100 volumio[14993]: verbose: ControllerMpd::sendMpdCommand status May 23 19:10:39 smsl-n100 volumio[14993]: info: May 23 19:10:39 smsl-n100 volumio[14993]: ---------------------------- MPD announces state update: player May 23 19:10:39 smsl-n100 volumio[14993]: info: sendMpdCommand status took 8 milliseconds May 23 19:10:39 smsl-n100 volumio[14993]: info: ControllerMpd::getState May 23 19:10:39 smsl-n100 volumio[14993]: verbose: ControllerMpd::sendMpdCommand status May 23 19:10:39 smsl-n100 volumio[14993]: info: sendMpdCommand status took 5 milliseconds May 23 19:10:39 smsl-n100 volumio[14993]: verbose: ControllerMpd::parseState May 23 19:10:39 smsl-n100 volumio[14993]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 23 19:10:39 smsl-n100 volumio[14993]: verbose: ControllerMpd::parseState May 23 19:10:39 smsl-n100 volumio[14993]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 23 19:10:39 smsl-n100 volumio[14993]: info: May 23 19:10:39 smsl-n100 volumio[14993]: ---------------------------- MPD announces state update: player May 23 19:10:39 smsl-n100 volumio[14993]: info: ControllerMpd::getState May 23 19:10:39 smsl-n100 volumio[14993]: verbose: ControllerMpd::sendMpdCommand status May 23 19:10:39 smsl-n100 volumio[14993]: info: sendMpdCommand status took 16 milliseconds May 23 19:10:39 smsl-n100 volumio[14993]: info: sendMpdCommand playlistinfo took 15 milliseconds May 23 19:10:39 smsl-n100 volumio[14993]: info: sendMpdCommand playlistinfo took 13 milliseconds May 23 19:10:39 smsl-n100 volumio[14993]: info: sendMpdCommand status took 5 milliseconds May 23 19:10:39 smsl-n100 volumio[14993]: verbose: ControllerMpd::parseState May 23 19:10:39 smsl-n100 volumio[14993]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 23 19:10:39 smsl-n100 volumio[14993]: verbose: ControllerMpd::parseTrackInfo May 23 19:10:39 smsl-n100 volumio[14993]: verbose: ControllerMpd::parseTrackInfo May 23 19:10:39 smsl-n100 volumio[14993]: verbose: ControllerMpd::parseState May 23 19:10:39 smsl-n100 volumio[14993]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 23 19:10:39 smsl-n100 volumio[14993]: info: ControllerMpd::pushState May 23 19:10:39 smsl-n100 volumio[14993]: info: CoreCommandRouter::servicePushState May 23 19:10:39 smsl-n100 volumio[14993]: info: CorePlayQueue::getTrack 2 May 23 19:10:39 smsl-n100 volumio[14993]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":219,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"3","artist":null,"album":null,"uri":"cdda:///3","trackType":"CD Audio"} May 23 19:10:39 smsl-n100 volumio[14993]: verbose: CURRENT POSITION 2 May 23 19:10:39 smsl-n100 volumio[14993]: info: CoreStateMachine::syncState stateService play May 23 19:10:39 smsl-n100 volumio[14993]: info: CoreStateMachine::syncState currentStatus stop May 23 19:10:39 smsl-n100 volumio[14993]: info: ControllerMpd::pushState May 23 19:10:39 smsl-n100 volumio[14993]: info: CoreCommandRouter::servicePushState May 23 19:10:39 smsl-n100 volumio[14993]: info: CorePlayQueue::getTrack 2 May 23 19:10:39 smsl-n100 volumio[14993]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":219,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"3","artist":null,"album":null,"uri":"cdda:///3","trackType":"CD Audio"} May 23 19:10:39 smsl-n100 volumio[14993]: verbose: CURRENT POSITION 2 May 23 19:10:39 smsl-n100 volumio[14993]: info: CoreStateMachine::syncState stateService play May 23 19:10:39 smsl-n100 volumio[14993]: info: CoreStateMachine::syncState currentStatus play May 23 19:10:39 smsl-n100 volumio[14993]: info: Received an update from plugin. extracting info from payload May 23 19:10:39 smsl-n100 volumio[14993]: info: CoreStateMachine::pushState May 23 19:10:39 smsl-n100 volumio[14993]: info: CorePlayQueue::getTrack 2 May 23 19:10:39 smsl-n100 volumio[14993]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 23 19:10:39 smsl-n100 volumio[14993]: info: CoreCommandRouter::volumioPushState May 23 19:10:39 smsl-n100 volumio[14993]: info: MRS: Pushing multiroomSync output update for this device May 23 19:10:39 smsl-n100 volumio[14993]: info: MRS: Pushing multiroomSync output May 23 19:10:39 smsl-n100 volumio[14993]: info: CoreStateMachine::pushState May 23 19:10:39 smsl-n100 volumio[14993]: info: CorePlayQueue::getTrack 2 May 23 19:10:39 smsl-n100 volumio[14993]: info: CoreCommandRouter::volumioPushState May 23 19:10:39 smsl-n100 volumio[14993]: info: MRS: Pushing multiroomSync output update for this device May 23 19:10:39 smsl-n100 volumio[14993]: info: MRS: Pushing multiroomSync output May 23 19:10:39 smsl-n100 volumio[14993]: info: ------------------------------ 65ms May 23 19:10:39 smsl-n100 volumio[14993]: info: ------------------------------ 79ms May 23 19:10:39 smsl-n100 volumio[14993]: info: sendMpdCommand playlistinfo took 54 milliseconds May 23 19:10:39 smsl-n100 volumio[14993]: info: sendMpdCommand playlistinfo took 51 milliseconds May 23 19:10:39 smsl-n100 volumio[14993]: verbose: ControllerMpd::parseTrackInfo May 23 19:10:39 smsl-n100 volumio[14993]: verbose: ControllerMpd::parseTrackInfo May 23 19:10:39 smsl-n100 volumio[14993]: info: ControllerMpd::pushState May 23 19:10:39 smsl-n100 volumio[14993]: info: CoreCommandRouter::servicePushState May 23 19:10:39 smsl-n100 volumio[14993]: info: CorePlayQueue::getTrack 2 May 23 19:10:39 smsl-n100 volumio[14993]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":219,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"3","artist":null,"album":null,"uri":"cdda:///3","trackType":"CD Audio"} May 23 19:10:39 smsl-n100 volumio[14993]: verbose: CURRENT POSITION 2 May 23 19:10:39 smsl-n100 volumio[14993]: info: CoreStateMachine::syncState stateService play May 23 19:10:39 smsl-n100 volumio[14993]: info: CoreStateMachine::syncState currentStatus play May 23 19:10:39 smsl-n100 volumio[14993]: info: Received an update from plugin. extracting info from payload May 23 19:10:39 smsl-n100 volumio[14993]: info: CoreStateMachine::pushState May 23 19:10:39 smsl-n100 volumio[14993]: info: CorePlayQueue::getTrack 2 May 23 19:10:39 smsl-n100 volumio[14993]: info: CoreCommandRouter::volumioPushState May 23 19:10:39 smsl-n100 volumio[14993]: info: MRS: Pushing multiroomSync output update for this device May 23 19:10:39 smsl-n100 volumio[14993]: info: MRS: Pushing multiroomSync output May 23 19:10:39 smsl-n100 volumio[14993]: info: CoreStateMachine::pushState May 23 19:10:39 smsl-n100 volumio[14993]: info: CorePlayQueue::getTrack 2 May 23 19:10:39 smsl-n100 volumio[14993]: info: CoreCommandRouter::volumioPushState May 23 19:10:39 smsl-n100 volumio[14993]: info: MRS: Pushing multiroomSync output update for this device May 23 19:10:39 smsl-n100 volumio[14993]: info: MRS: Pushing multiroomSync output May 23 19:10:39 smsl-n100 volumio[14993]: info: ControllerMpd::pushState May 23 19:10:39 smsl-n100 volumio[14993]: info: CoreCommandRouter::servicePushState May 23 19:10:39 smsl-n100 volumio[14993]: info: CorePlayQueue::getTrack 2 May 23 19:10:39 smsl-n100 volumio[14993]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":219,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"3","artist":null,"album":null,"uri":"cdda:///3","trackType":"CD Audio"} May 23 19:10:39 smsl-n100 volumio[14993]: verbose: CURRENT POSITION 2 May 23 19:10:39 smsl-n100 volumio[14993]: info: CoreStateMachine::syncState stateService play May 23 19:10:39 smsl-n100 volumio[14993]: info: CoreStateMachine::syncState currentStatus play May 23 19:10:39 smsl-n100 volumio[14993]: info: Received an update from plugin. extracting info from payload May 23 19:10:39 smsl-n100 volumio[14993]: info: CoreStateMachine::pushState May 23 19:10:39 smsl-n100 volumio[14993]: info: CorePlayQueue::getTrack 2 May 23 19:10:39 smsl-n100 volumio[14993]: info: CoreCommandRouter::volumioPushState May 23 19:10:39 smsl-n100 volumio[14993]: info: MRS: Pushing multiroomSync output update for this device May 23 19:10:39 smsl-n100 volumio[14993]: info: MRS: Pushing multiroomSync output May 23 19:10:39 smsl-n100 volumio[14993]: info: CoreStateMachine::pushState May 23 19:10:39 smsl-n100 volumio[14993]: info: CorePlayQueue::getTrack 2 May 23 19:10:39 smsl-n100 volumio[14993]: info: CoreCommandRouter::volumioPushState May 23 19:10:39 smsl-n100 volumio[14993]: info: MRS: Pushing multiroomSync output update for this device May 23 19:10:39 smsl-n100 volumio[14993]: info: MRS: Pushing multiroomSync output May 23 19:10:39 smsl-n100 volumio[14993]: info: ------------------------------ 156ms May 23 19:10:39 smsl-n100 volumio[14993]: info: ------------------------------ 149ms May 23 19:10:39 smsl-n100 volumio[14993]: info: Updating RAAT Signal Path May 23 19:10:39 smsl-n100 volumio[14993]: info: Updating RAAT Signal Path May 23 19:10:39 smsl-n100 volumio[14993]: info: Updating RAAT Signal Path May 23 19:10:39 smsl-n100 volumio[14993]: info: Updating RAAT Signal Path May 23 19:10:39 smsl-n100 volumio[14993]: info: Updating RAAT Signal Path May 23 19:10:39 smsl-n100 volumio[14993]: info: Updating RAAT Signal Path May 23 19:10:39 smsl-n100 volumio[14993]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Saybia/These%20Are%20the%20Days/87bdaf05-a41a-40ee-8bd9-6b1cb443c19d.jpg' May 23 19:10:39 smsl-n100 volumio[14993]: info: CoreStateMachine::pushState May 23 19:10:39 smsl-n100 volumio[14993]: info: CorePlayQueue::getTrack 2 May 23 19:10:39 smsl-n100 volumio[14993]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 23 19:10:39 smsl-n100 volumio[14993]: info: CoreCommandRouter::volumioPushState May 23 19:10:39 smsl-n100 volumio[14993]: info: MRS: Pushing multiroomSync output update for this device May 23 19:10:39 smsl-n100 volumio[14993]: info: MRS: Pushing multiroomSync output May 23 19:10:39 smsl-n100 volumio[14993]: error: Serial API: Failed to decode command: 100, message: undefined May 23 19:10:39 smsl-n100 volumio[14993]: error: Serial API: Failed to decode command: MAXVOL, message: May 23 19:10:39 smsl-n100 volumio[14993]: error: Serial API: Failed to decode command: 100, message: undefined May 23 19:10:39 smsl-n100 volumio[14993]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff May 23 19:10:39 smsl-n100 volumio[14993]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Saybia/These%20Are%20the%20Days/87bdaf05-a41a-40ee-8bd9-6b1cb443c19d.jpg' May 23 19:10:39 smsl-n100 volumio[14993]: info: VolumeController::SetAlsaVolume0 May 23 19:10:39 smsl-n100 volumio[14993]: info: CoreStateMachine::pushState May 23 19:10:39 smsl-n100 volumio[14993]: info: CorePlayQueue::getTrack 2 May 23 19:10:39 smsl-n100 volumio[14993]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 23 19:10:39 smsl-n100 volumio[14993]: info: CoreCommandRouter::volumioPushState May 23 19:10:39 smsl-n100 volumio[14993]: info: MRS: Pushing multiroomSync output update for this device May 23 19:10:39 smsl-n100 volumio[14993]: info: MRS: Pushing multiroomSync output May 23 19:10:39 smsl-n100 volumio[14993]: info: Updating RAAT Signal Path May 23 19:11:16 smsl-n100 volumio[14993]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 23 19:11:16 smsl-n100 volumio[14993]: Error: connect ETIMEDOUT 31.13.87.9:443 May 23 19:11:16 smsl-n100 volumio[14993]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { May 23 19:11:16 smsl-n100 volumio[14993]: errno: -110, May 23 19:11:16 smsl-n100 volumio[14993]: code: 'ETIMEDOUT', May 23 19:11:16 smsl-n100 volumio[14993]: syscall: 'connect', May 23 19:11:16 smsl-n100 volumio[14993]: address: '31.13.87.9', May 23 19:11:16 smsl-n100 volumio[14993]: port: 443 May 23 19:11:16 smsl-n100 volumio[14993]: } May 23 19:11:16 smsl-n100 volumio[14993]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 23 19:11:17 smsl-n100 sudo[21726]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-23 19:10 May 23 19:11:17 smsl-n100 sudo[21726]: 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="cc0042a1eab1cb7982711a1347e242f8947b54b6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="723ba1d50268911818ebdca474fb7656df6050cb" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="smsl" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 14 Feb 2025 02:46:15 PM CET" VOLUMIO_VERSION="3.789" VOLUMIO_HARDWARE="nanopineo3" VOLUMIO_DEVICENAME="Nanopi Neo3" VOLUMIO_VENDOR_MODEL="SMSL S100" VOLUMIO_VENDOR="SMSL" VOLUMIO_MODEL="S100" VOLUMIO_HASH="215d731aee688e00fb3cc923952be9a7"