-- Logs begin at Thu 2019-02-14 13:11:59 MSK, end at Tue 2026-03-24 19:22:38 MSK. -- Mar 24 19:21:32 smsl-n100 volumio[999]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found Mar 24 19:21:32 smsl-n100 volumio[999]: at SendStream.error (/volumio/node_modules/send/index.js:270:31) Mar 24 19:21:32 smsl-n100 volumio[999]: at SendStream.pipe (/volumio/node_modules/send/index.js:584:14) Mar 24 19:21:32 smsl-n100 volumio[999]: at sendfile (/volumio/node_modules/express/lib/response.js:1103:8) Mar 24 19:21:32 smsl-n100 volumio[999]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:433:3) Mar 24 19:21:32 smsl-n100 volumio[999]: at Promise._failFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:449:13) Mar 24 19:21:32 smsl-n100 volumio[999]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Mar 24 19:21:32 smsl-n100 volumio[999]: at processTicksAndRejections (internal/process/task_queues.js:77:11) Mar 24 19:21:50 smsl-n100 volumio[999]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 24 19:21:50 smsl-n100 volumio[999]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 24 19:21:50 smsl-n100 volumio[999]: info: Retrieving Cloud Streaming UI Mar 24 19:21:50 smsl-n100 volumio[999]: info: Getting Tidal Cloud Configuration Mar 24 19:21:50 smsl-n100 volumio[999]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 24 19:21:50 smsl-n100 volumio[999]: info: Getting Qobuz Cloud Configuration Mar 24 19:21:50 smsl-n100 volumio[999]: info: Asking plugin for UI Config Mar 24 19:21:50 smsl-n100 volumio[999]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 24 19:21:50 smsl-n100 volumio[999]: info: Getting Spotify Cloud Configuration Mar 24 19:21:50 smsl-n100 volumio[999]: info: Asking plugin for UI Config Mar 24 19:21:50 smsl-n100 volumio[999]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 24 19:21:50 smsl-n100 volumio[999]: info: Saving Spotify Acccount Mar 24 19:21:50 smsl-n100 volumio[999]: info: Got it Mar 24 19:21:50 smsl-n100 volumio[999]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Mar 24 19:21:50 smsl-n100 volumio[999]: info: Got Tidal Cloud Configuration Mar 24 19:21:50 smsl-n100 volumio[999]: info: Got it Mar 24 19:21:50 smsl-n100 volumio[999]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 24 19:21:50 smsl-n100 volumio[999]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 24 19:21:50 smsl-n100 volumio[999]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 24 19:21:50 smsl-n100 volumio[999]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 24 19:21:50 smsl-n100 volumio[999]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 24 19:21:50 smsl-n100 volumio[999]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 24 19:21:50 smsl-n100 volumio[999]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 24 19:21:50 smsl-n100 volumio[999]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 24 19:21:50 smsl-n100 volumio[999]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 24 19:21:50 smsl-n100 volumio[999]: info: CoreCommandRouter::volumioGetBrowseSources Mar 24 19:21:50 smsl-n100 volumio[999]: info: CoreCommandRouter::volumioGetBrowseSources Mar 24 19:21:50 smsl-n100 volumio[999]: info: CoreCommandRouter::volumioGetBrowseSources Mar 24 19:21:50 smsl-n100 volumio[999]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 24 19:21:50 smsl-n100 volumio[999]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Mar 24 19:21:54 smsl-n100 volumio[999]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 24 19:21:56 smsl-n100 volumio[999]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Mar 24 19:21:56 smsl-n100 volumio[999]: verbose: ControllerMpd::sendMpdCommand update Mar 24 19:21:56 smsl-n100 volumio[999]: verbose: ControllerMpd::sendMpdCommand status Mar 24 19:21:56 smsl-n100 volumio[999]: info: Mar 24 19:21:56 smsl-n100 volumio[999]: ---------------------------- MPD announces state update: update Mar 24 19:21:56 smsl-n100 volumio[999]: info: sendMpdCommand update took 14 milliseconds Mar 24 19:21:56 smsl-n100 volumio[999]: info: ControllerMpd::getState Mar 24 19:21:56 smsl-n100 volumio[999]: verbose: ControllerMpd::sendMpdCommand status Mar 24 19:21:56 smsl-n100 volumio[999]: info: sendMpdCommand status took 11 milliseconds Mar 24 19:21:56 smsl-n100 volumio[999]: info: sendMpdCommand status took 6 milliseconds Mar 24 19:21:56 smsl-n100 volumio[999]: verbose: ControllerMpd::parseState Mar 24 19:21:56 smsl-n100 volumio[999]: info: Command Router : Notfying DB Updatetrue Mar 24 19:21:56 smsl-n100 volumio[999]: verbose: ControllerMpd::parseState Mar 24 19:21:56 smsl-n100 volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 19:21:56 smsl-n100 volumio[999]: verbose: ControllerMpd::sendMpdCommand status Mar 24 19:21:56 smsl-n100 volumio[999]: info: Mar 24 19:21:56 smsl-n100 volumio[999]: ---------------------------- MPD announces state update: update Mar 24 19:21:56 smsl-n100 volumio[999]: info: ControllerMpd::getState Mar 24 19:21:56 smsl-n100 volumio[999]: verbose: ControllerMpd::sendMpdCommand status Mar 24 19:21:56 smsl-n100 volumio[999]: verbose: ControllerMpd::sendMpdCommand status Mar 24 19:21:56 smsl-n100 volumio[999]: info: Mar 24 19:21:56 smsl-n100 volumio[999]: ---------------------------- MPD announces state update: update Mar 24 19:21:56 smsl-n100 volumio[999]: info: ControllerMpd::getState Mar 24 19:21:56 smsl-n100 volumio[999]: verbose: ControllerMpd::sendMpdCommand status Mar 24 19:21:56 smsl-n100 volumio[999]: info: MPD Database updated - AlbumList cache refreshed Mar 24 19:21:56 smsl-n100 volumio[999]: info: Mar 24 19:21:56 smsl-n100 volumio[999]: ---------------------------- MPD announces state update: database Mar 24 19:21:56 smsl-n100 volumio[999]: verbose: ControllerMpd::sendMpdCommand status Mar 24 19:21:56 smsl-n100 volumio[999]: info: Mar 24 19:21:56 smsl-n100 volumio[999]: ---------------------------- MPD announces state update: update Mar 24 19:21:56 smsl-n100 volumio[999]: info: ControllerMpd::getState Mar 24 19:21:56 smsl-n100 volumio[999]: verbose: ControllerMpd::sendMpdCommand status Mar 24 19:21:56 smsl-n100 volumio[999]: info: ControllerMpd::getState Mar 24 19:21:56 smsl-n100 volumio[999]: verbose: ControllerMpd::sendMpdCommand status Mar 24 19:21:56 smsl-n100 volumio[999]: info: sendMpdCommand playlistinfo took 41 milliseconds Mar 24 19:21:56 smsl-n100 volumio[999]: info: sendMpdCommand status took 31 milliseconds Mar 24 19:21:56 smsl-n100 volumio[999]: info: sendMpdCommand status took 28 milliseconds Mar 24 19:21:56 smsl-n100 volumio[999]: info: sendMpdCommand status took 25 milliseconds Mar 24 19:21:56 smsl-n100 volumio[999]: info: sendMpdCommand status took 22 milliseconds Mar 24 19:21:56 smsl-n100 volumio[999]: verbose: ControllerMpd::parseTrackInfo Mar 24 19:21:56 smsl-n100 volumio[999]: verbose: ControllerMpd::parseState Mar 24 19:21:56 smsl-n100 volumio[999]: info: Command Router : Notfying DB Updatefalse Mar 24 19:21:56 smsl-n100 volumio[999]: info: CoreCommandRouter::Close All Modals sent Mar 24 19:21:56 smsl-n100 volumio[999]: verbose: ControllerMpd::parseState Mar 24 19:21:56 smsl-n100 volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 19:21:56 smsl-n100 volumio[999]: verbose: ControllerMpd::parseState Mar 24 19:21:56 smsl-n100 volumio[999]: info: Command Router : Notfying DB Updatefalse Mar 24 19:21:56 smsl-n100 volumio[999]: info: CoreCommandRouter::Close All Modals sent Mar 24 19:21:56 smsl-n100 volumio[999]: verbose: ControllerMpd::parseState Mar 24 19:21:56 smsl-n100 volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 19:21:56 smsl-n100 volumio[999]: info: ControllerMpd::pushState Mar 24 19:21:56 smsl-n100 volumio[999]: info: CoreCommandRouter::servicePushState Mar 24 19:21:56 smsl-n100 volumio[999]: info: CorePlayQueue::getTrack 0 Mar 24 19:21:56 smsl-n100 volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":88705,"duration":250,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"1","artist":null,"album":null,"uri":"cdda:///1","trackType":"CD Audio"} Mar 24 19:21:56 smsl-n100 volumio[999]: verbose: CURRENT POSITION 0 Mar 24 19:21:56 smsl-n100 volumio[999]: info: CoreStateMachine::syncState stateService play Mar 24 19:21:56 smsl-n100 volumio[999]: info: CoreStateMachine::syncState currentStatus play Mar 24 19:21:56 smsl-n100 volumio[999]: info: Received an update from plugin. extracting info from payload Mar 24 19:21:56 smsl-n100 volumio[999]: info: CoreStateMachine::pushState Mar 24 19:21:56 smsl-n100 volumio[999]: info: CorePlayQueue::getTrack 0 Mar 24 19:21:56 smsl-n100 volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 24 19:21:56 smsl-n100 volumio[999]: info: CoreCommandRouter::volumioPushState Mar 24 19:21:56 smsl-n100 volumio[999]: info: MRS: Pushing multiroomSync output update for this device Mar 24 19:21:56 smsl-n100 volumio[999]: info: MRS: Pushing multiroomSync output Mar 24 19:21:56 smsl-n100 volumio[999]: info: CoreStateMachine::pushState Mar 24 19:21:56 smsl-n100 volumio[999]: info: CorePlayQueue::getTrack 0 Mar 24 19:21:56 smsl-n100 volumio[999]: info: CoreCommandRouter::volumioPushState Mar 24 19:21:56 smsl-n100 volumio[999]: info: MRS: Pushing multiroomSync output update for this device Mar 24 19:21:56 smsl-n100 volumio[999]: info: MRS: Pushing multiroomSync output Mar 24 19:21:56 smsl-n100 volumio[999]: info: ------------------------------ 379ms Mar 24 19:21:56 smsl-n100 volumio[999]: info: MPD Database updated - AlbumList cache refreshed Mar 24 19:21:56 smsl-n100 volumio[999]: info: Mar 24 19:21:56 smsl-n100 volumio[999]: ---------------------------- MPD announces state update: database Mar 24 19:21:56 smsl-n100 volumio[999]: verbose: ControllerMpd::sendMpdCommand status Mar 24 19:21:56 smsl-n100 volumio[999]: info: Mar 24 19:21:56 smsl-n100 volumio[999]: ---------------------------- MPD announces state update: update Mar 24 19:21:56 smsl-n100 volumio[999]: info: ControllerMpd::getState Mar 24 19:21:56 smsl-n100 volumio[999]: verbose: ControllerMpd::sendMpdCommand status Mar 24 19:21:56 smsl-n100 volumio[999]: info: ControllerMpd::getState Mar 24 19:21:56 smsl-n100 volumio[999]: verbose: ControllerMpd::sendMpdCommand status Mar 24 19:21:56 smsl-n100 volumio[999]: info: MPD Database updated - AlbumList cache refreshed Mar 24 19:21:56 smsl-n100 volumio[999]: info: Mar 24 19:21:56 smsl-n100 volumio[999]: ---------------------------- MPD announces state update: database Mar 24 19:21:56 smsl-n100 volumio[999]: verbose: ControllerMpd::sendMpdCommand status Mar 24 19:21:56 smsl-n100 volumio[999]: info: Mar 24 19:21:56 smsl-n100 volumio[999]: ---------------------------- MPD announces state update: update Mar 24 19:21:56 smsl-n100 volumio[999]: info: ControllerMpd::getState Mar 24 19:21:56 smsl-n100 volumio[999]: verbose: ControllerMpd::sendMpdCommand status Mar 24 19:21:56 smsl-n100 volumio[999]: info: ControllerMpd::getState Mar 24 19:21:56 smsl-n100 volumio[999]: verbose: ControllerMpd::sendMpdCommand status Mar 24 19:21:56 smsl-n100 volumio[999]: info: sendMpdCommand status took 289 milliseconds Mar 24 19:21:56 smsl-n100 volumio[999]: info: sendMpdCommand status took 285 milliseconds Mar 24 19:21:56 smsl-n100 volumio[999]: info: sendMpdCommand status took 283 milliseconds Mar 24 19:21:56 smsl-n100 volumio[999]: info: sendMpdCommand playlistinfo took 216 milliseconds Mar 24 19:21:56 smsl-n100 volumio[999]: info: sendMpdCommand playlistinfo took 167 milliseconds Mar 24 19:21:56 smsl-n100 volumio[999]: info: sendMpdCommand status took 70 milliseconds Mar 24 19:21:56 smsl-n100 volumio[999]: info: sendMpdCommand status took 67 milliseconds Mar 24 19:21:56 smsl-n100 volumio[999]: info: sendMpdCommand status took 65 milliseconds Mar 24 19:21:56 smsl-n100 volumio[999]: info: sendMpdCommand status took 61 milliseconds Mar 24 19:21:56 smsl-n100 volumio[999]: info: sendMpdCommand status took 58 milliseconds Mar 24 19:21:56 smsl-n100 volumio[999]: info: sendMpdCommand status took 56 milliseconds Mar 24 19:21:56 smsl-n100 volumio[999]: verbose: ControllerMpd::parseState Mar 24 19:21:57 smsl-n100 volumio[999]: info: Command Router : Notfying DB Updatefalse Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreCommandRouter::Close All Modals sent Mar 24 19:21:57 smsl-n100 volumio[999]: verbose: ControllerMpd::parseState Mar 24 19:21:57 smsl-n100 volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 19:21:57 smsl-n100 volumio[999]: verbose: ControllerMpd::parseState Mar 24 19:21:57 smsl-n100 volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 19:21:57 smsl-n100 volumio[999]: verbose: ControllerMpd::parseTrackInfo Mar 24 19:21:57 smsl-n100 volumio[999]: verbose: ControllerMpd::parseTrackInfo Mar 24 19:21:57 smsl-n100 volumio[999]: verbose: ControllerMpd::parseState Mar 24 19:21:57 smsl-n100 volumio[999]: info: Command Router : Notfying DB Updatefalse Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreCommandRouter::Close All Modals sent Mar 24 19:21:57 smsl-n100 volumio[999]: verbose: ControllerMpd::parseState Mar 24 19:21:57 smsl-n100 volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 19:21:57 smsl-n100 volumio[999]: verbose: ControllerMpd::parseState Mar 24 19:21:57 smsl-n100 volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 19:21:57 smsl-n100 volumio[999]: verbose: ControllerMpd::parseState Mar 24 19:21:57 smsl-n100 volumio[999]: info: Command Router : Notfying DB Updatefalse Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreCommandRouter::Close All Modals sent Mar 24 19:21:57 smsl-n100 volumio[999]: verbose: ControllerMpd::parseState Mar 24 19:21:57 smsl-n100 volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 19:21:57 smsl-n100 volumio[999]: verbose: ControllerMpd::parseState Mar 24 19:21:57 smsl-n100 volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 19:21:57 smsl-n100 volumio[999]: info: ControllerMpd::pushState Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreCommandRouter::servicePushState Mar 24 19:21:57 smsl-n100 volumio[999]: info: CorePlayQueue::getTrack 0 Mar 24 19:21:57 smsl-n100 volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":88956,"duration":250,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"1","artist":null,"album":null,"uri":"cdda:///1","trackType":"CD Audio"} Mar 24 19:21:57 smsl-n100 volumio[999]: verbose: CURRENT POSITION 0 Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreStateMachine::syncState stateService play Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreStateMachine::syncState currentStatus play Mar 24 19:21:57 smsl-n100 volumio[999]: info: Received an update from plugin. extracting info from payload Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreStateMachine::pushState Mar 24 19:21:57 smsl-n100 volumio[999]: info: CorePlayQueue::getTrack 0 Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreCommandRouter::volumioPushState Mar 24 19:21:57 smsl-n100 volumio[999]: info: MRS: Pushing multiroomSync output update for this device Mar 24 19:21:57 smsl-n100 volumio[999]: info: MRS: Pushing multiroomSync output Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreStateMachine::pushState Mar 24 19:21:57 smsl-n100 volumio[999]: info: CorePlayQueue::getTrack 0 Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreCommandRouter::volumioPushState Mar 24 19:21:57 smsl-n100 volumio[999]: info: MRS: Pushing multiroomSync output update for this device Mar 24 19:21:57 smsl-n100 volumio[999]: info: MRS: Pushing multiroomSync output Mar 24 19:21:57 smsl-n100 volumio[999]: info: ControllerMpd::pushState Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreCommandRouter::servicePushState Mar 24 19:21:57 smsl-n100 volumio[999]: info: CorePlayQueue::getTrack 0 Mar 24 19:21:57 smsl-n100 volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":88956,"duration":250,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"1","artist":null,"album":null,"uri":"cdda:///1","trackType":"CD Audio"} Mar 24 19:21:57 smsl-n100 volumio[999]: verbose: CURRENT POSITION 0 Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreStateMachine::syncState stateService play Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreStateMachine::syncState currentStatus play Mar 24 19:21:57 smsl-n100 volumio[999]: info: Received an update from plugin. extracting info from payload Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreStateMachine::pushState Mar 24 19:21:57 smsl-n100 volumio[999]: info: CorePlayQueue::getTrack 0 Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreCommandRouter::volumioPushState Mar 24 19:21:57 smsl-n100 volumio[999]: info: MRS: Pushing multiroomSync output update for this device Mar 24 19:21:57 smsl-n100 volumio[999]: info: MRS: Pushing multiroomSync output Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreStateMachine::pushState Mar 24 19:21:57 smsl-n100 volumio[999]: info: CorePlayQueue::getTrack 0 Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreCommandRouter::volumioPushState Mar 24 19:21:57 smsl-n100 volumio[999]: info: MRS: Pushing multiroomSync output update for this device Mar 24 19:21:57 smsl-n100 volumio[999]: info: MRS: Pushing multiroomSync output Mar 24 19:21:57 smsl-n100 volumio[999]: info: ------------------------------ 1074ms Mar 24 19:21:57 smsl-n100 volumio[999]: info: ------------------------------ 1069ms Mar 24 19:21:57 smsl-n100 volumio[999]: info: sendMpdCommand playlistinfo took 302 milliseconds Mar 24 19:21:57 smsl-n100 volumio[999]: info: sendMpdCommand playlistinfo took 301 milliseconds Mar 24 19:21:57 smsl-n100 volumio[999]: info: sendMpdCommand playlistinfo took 246 milliseconds Mar 24 19:21:57 smsl-n100 volumio[999]: info: sendMpdCommand playlistinfo took 245 milliseconds Mar 24 19:21:57 smsl-n100 volumio[999]: info: sendMpdCommand playlistinfo took 186 milliseconds Mar 24 19:21:57 smsl-n100 volumio[999]: info: sendMpdCommand playlistinfo took 185 milliseconds Mar 24 19:21:57 smsl-n100 volumio[999]: verbose: ControllerMpd::parseTrackInfo Mar 24 19:21:57 smsl-n100 volumio[999]: verbose: ControllerMpd::parseTrackInfo Mar 24 19:21:57 smsl-n100 volumio[999]: verbose: ControllerMpd::parseTrackInfo Mar 24 19:21:57 smsl-n100 volumio[999]: verbose: ControllerMpd::parseTrackInfo Mar 24 19:21:57 smsl-n100 volumio[999]: verbose: ControllerMpd::parseTrackInfo Mar 24 19:21:57 smsl-n100 volumio[999]: verbose: ControllerMpd::parseTrackInfo Mar 24 19:21:57 smsl-n100 volumio[999]: info: ControllerMpd::pushState Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreCommandRouter::servicePushState Mar 24 19:21:57 smsl-n100 volumio[999]: info: CorePlayQueue::getTrack 0 Mar 24 19:21:57 smsl-n100 volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":88956,"duration":250,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"1","artist":null,"album":null,"uri":"cdda:///1","trackType":"CD Audio"} Mar 24 19:21:57 smsl-n100 volumio[999]: verbose: CURRENT POSITION 0 Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreStateMachine::syncState stateService play Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreStateMachine::syncState currentStatus play Mar 24 19:21:57 smsl-n100 volumio[999]: info: Received an update from plugin. extracting info from payload Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreStateMachine::pushState Mar 24 19:21:57 smsl-n100 volumio[999]: info: CorePlayQueue::getTrack 0 Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreCommandRouter::volumioPushState Mar 24 19:21:57 smsl-n100 volumio[999]: info: MRS: Pushing multiroomSync output update for this device Mar 24 19:21:57 smsl-n100 volumio[999]: info: MRS: Pushing multiroomSync output Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreStateMachine::pushState Mar 24 19:21:57 smsl-n100 volumio[999]: info: CorePlayQueue::getTrack 0 Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreCommandRouter::volumioPushState Mar 24 19:21:57 smsl-n100 volumio[999]: info: MRS: Pushing multiroomSync output update for this device Mar 24 19:21:57 smsl-n100 volumio[999]: info: MRS: Pushing multiroomSync output Mar 24 19:21:57 smsl-n100 volumio[999]: info: ControllerMpd::pushState Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreCommandRouter::servicePushState Mar 24 19:21:57 smsl-n100 volumio[999]: info: CorePlayQueue::getTrack 0 Mar 24 19:21:57 smsl-n100 volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":88956,"duration":250,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"1","artist":null,"album":null,"uri":"cdda:///1","trackType":"CD Audio"} Mar 24 19:21:57 smsl-n100 volumio[999]: verbose: CURRENT POSITION 0 Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreStateMachine::syncState stateService play Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreStateMachine::syncState currentStatus play Mar 24 19:21:57 smsl-n100 volumio[999]: info: Received an update from plugin. extracting info from payload Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreStateMachine::pushState Mar 24 19:21:57 smsl-n100 volumio[999]: info: CorePlayQueue::getTrack 0 Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreCommandRouter::volumioPushState Mar 24 19:21:57 smsl-n100 volumio[999]: info: MRS: Pushing multiroomSync output update for this device Mar 24 19:21:57 smsl-n100 volumio[999]: info: MRS: Pushing multiroomSync output Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreStateMachine::pushState Mar 24 19:21:57 smsl-n100 volumio[999]: info: CorePlayQueue::getTrack 0 Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreCommandRouter::volumioPushState Mar 24 19:21:57 smsl-n100 volumio[999]: info: MRS: Pushing multiroomSync output update for this device Mar 24 19:21:57 smsl-n100 volumio[999]: info: MRS: Pushing multiroomSync output Mar 24 19:21:57 smsl-n100 volumio[999]: info: ControllerMpd::pushState Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreCommandRouter::servicePushState Mar 24 19:21:57 smsl-n100 volumio[999]: info: CorePlayQueue::getTrack 0 Mar 24 19:21:57 smsl-n100 volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":89208,"duration":250,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"1","artist":null,"album":null,"uri":"cdda:///1","trackType":"CD Audio"} Mar 24 19:21:57 smsl-n100 volumio[999]: verbose: CURRENT POSITION 0 Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreStateMachine::syncState stateService play Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreStateMachine::syncState currentStatus play Mar 24 19:21:57 smsl-n100 volumio[999]: info: Received an update from plugin. extracting info from payload Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreStateMachine::pushState Mar 24 19:21:57 smsl-n100 volumio[999]: info: CorePlayQueue::getTrack 0 Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreCommandRouter::volumioPushState Mar 24 19:21:57 smsl-n100 volumio[999]: info: MRS: Pushing multiroomSync output update for this device Mar 24 19:21:57 smsl-n100 volumio[999]: info: MRS: Pushing multiroomSync output Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreStateMachine::pushState Mar 24 19:21:57 smsl-n100 volumio[999]: info: CorePlayQueue::getTrack 0 Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreCommandRouter::volumioPushState Mar 24 19:21:57 smsl-n100 volumio[999]: info: MRS: Pushing multiroomSync output update for this device Mar 24 19:21:57 smsl-n100 volumio[999]: info: MRS: Pushing multiroomSync output Mar 24 19:21:57 smsl-n100 volumio[999]: info: ControllerMpd::pushState Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreCommandRouter::servicePushState Mar 24 19:21:57 smsl-n100 volumio[999]: info: CorePlayQueue::getTrack 0 Mar 24 19:21:57 smsl-n100 volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":89208,"duration":250,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"1","artist":null,"album":null,"uri":"cdda:///1","trackType":"CD Audio"} Mar 24 19:21:57 smsl-n100 volumio[999]: verbose: CURRENT POSITION 0 Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreStateMachine::syncState stateService play Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreStateMachine::syncState currentStatus play Mar 24 19:21:57 smsl-n100 volumio[999]: info: Received an update from plugin. extracting info from payload Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreStateMachine::pushState Mar 24 19:21:57 smsl-n100 volumio[999]: info: CorePlayQueue::getTrack 0 Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreCommandRouter::volumioPushState Mar 24 19:21:57 smsl-n100 volumio[999]: info: MRS: Pushing multiroomSync output update for this device Mar 24 19:21:57 smsl-n100 volumio[999]: info: MRS: Pushing multiroomSync output Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreStateMachine::pushState Mar 24 19:21:57 smsl-n100 volumio[999]: info: CorePlayQueue::getTrack 0 Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreCommandRouter::volumioPushState Mar 24 19:21:57 smsl-n100 volumio[999]: info: MRS: Pushing multiroomSync output update for this device Mar 24 19:21:57 smsl-n100 volumio[999]: info: MRS: Pushing multiroomSync output Mar 24 19:21:57 smsl-n100 volumio[999]: info: ControllerMpd::pushState Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreCommandRouter::servicePushState Mar 24 19:21:57 smsl-n100 volumio[999]: info: CorePlayQueue::getTrack 0 Mar 24 19:21:57 smsl-n100 volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":89208,"duration":250,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"1","artist":null,"album":null,"uri":"cdda:///1","trackType":"CD Audio"} Mar 24 19:21:57 smsl-n100 volumio[999]: verbose: CURRENT POSITION 0 Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreStateMachine::syncState stateService play Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreStateMachine::syncState currentStatus play Mar 24 19:21:57 smsl-n100 volumio[999]: info: Received an update from plugin. extracting info from payload Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreStateMachine::pushState Mar 24 19:21:57 smsl-n100 volumio[999]: info: CorePlayQueue::getTrack 0 Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreCommandRouter::volumioPushState Mar 24 19:21:57 smsl-n100 volumio[999]: info: MRS: Pushing multiroomSync output update for this device Mar 24 19:21:57 smsl-n100 volumio[999]: info: MRS: Pushing multiroomSync output Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreStateMachine::pushState Mar 24 19:21:57 smsl-n100 volumio[999]: info: CorePlayQueue::getTrack 0 Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreCommandRouter::volumioPushState Mar 24 19:21:57 smsl-n100 volumio[999]: info: MRS: Pushing multiroomSync output update for this device Mar 24 19:21:57 smsl-n100 volumio[999]: info: MRS: Pushing multiroomSync output Mar 24 19:21:57 smsl-n100 volumio[999]: info: ControllerMpd::pushState Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreCommandRouter::servicePushState Mar 24 19:21:57 smsl-n100 volumio[999]: info: CorePlayQueue::getTrack 0 Mar 24 19:21:57 smsl-n100 volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":89208,"duration":250,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"1","artist":null,"album":null,"uri":"cdda:///1","trackType":"CD Audio"} Mar 24 19:21:57 smsl-n100 volumio[999]: verbose: CURRENT POSITION 0 Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreStateMachine::syncState stateService play Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreStateMachine::syncState currentStatus play Mar 24 19:21:57 smsl-n100 volumio[999]: info: Received an update from plugin. extracting info from payload Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreStateMachine::pushState Mar 24 19:21:57 smsl-n100 volumio[999]: info: CorePlayQueue::getTrack 0 Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreCommandRouter::volumioPushState Mar 24 19:21:57 smsl-n100 volumio[999]: info: MRS: Pushing multiroomSync output update for this device Mar 24 19:21:57 smsl-n100 volumio[999]: info: MRS: Pushing multiroomSync output Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreStateMachine::pushState Mar 24 19:21:57 smsl-n100 volumio[999]: info: CorePlayQueue::getTrack 0 Mar 24 19:21:57 smsl-n100 volumio[999]: info: CoreCommandRouter::volumioPushState Mar 24 19:21:57 smsl-n100 volumio[999]: info: MRS: Pushing multiroomSync output update for this device Mar 24 19:21:57 smsl-n100 volumio[999]: info: MRS: Pushing multiroomSync output Mar 24 19:21:57 smsl-n100 volumio[999]: info: ------------------------------ 1422ms Mar 24 19:21:57 smsl-n100 volumio[999]: info: ------------------------------ 1427ms Mar 24 19:21:57 smsl-n100 volumio[999]: info: ------------------------------ 1208ms Mar 24 19:21:57 smsl-n100 volumio[999]: info: ------------------------------ 1207ms Mar 24 19:21:57 smsl-n100 volumio[999]: info: ------------------------------ 1199ms Mar 24 19:21:57 smsl-n100 volumio[999]: info: ------------------------------ 1206ms Mar 24 19:21:58 smsl-n100 volumio[999]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 24 19:22:02 smsl-n100 volumio[999]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 24 19:22:06 smsl-n100 volumio[999]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 24 19:22:10 smsl-n100 volumio[999]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 24 19:22:14 smsl-n100 volumio[999]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 24 19:22:18 smsl-n100 volumio[999]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 24 19:22:20 smsl-n100 volumio[999]: info: Disabling MyMusic plugin bluetooth Mar 24 19:22:20 smsl-n100 sudo[5740]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumiobt.service Mar 24 19:22:20 smsl-n100 sudo[5740]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 24 19:22:20 smsl-n100 systemd[1]: Stopping Volumio Bluetooth Module... Mar 24 19:22:20 smsl-n100 volumio[999]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 24 19:22:20 smsl-n100 volumiobt[5742]: Killing pulse Mar 24 19:22:20 smsl-n100 volumiobt[5742]: Killing BT Pair agent Mar 24 19:22:20 smsl-n100 systemd[1]: volumiobt.service: Main process exited, code=killed, status=15/TERM Mar 24 19:22:20 smsl-n100 systemd[1]: volumiobt.service: Succeeded. Mar 24 19:22:20 smsl-n100 systemd[1]: Stopped Volumio Bluetooth Module. Mar 24 19:22:20 smsl-n100 sudo[5740]: pam_unix(sudo:session): session closed for user root Mar 24 19:22:20 smsl-n100 volumio[999]: info: Volumio BT Module successfully stopped Mar 24 19:22:20 smsl-n100 volumio[999]: info: Disabling plugin bluetooth Mar 24 19:22:20 smsl-n100 volumio[999]: info: Done. Mar 24 19:22:22 smsl-n100 volumio[999]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 24 19:22:26 smsl-n100 volumio[999]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 24 19:22:30 smsl-n100 volumio[999]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 24 19:22:34 smsl-n100 volumio[999]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 24 19:22:37 smsl-n100 volumio[999]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Mar 24 19:22:37 smsl-n100 volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Mar 24 19:22:37 smsl-n100 volumio[999]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 24 19:22:37 smsl-n100 volumio[999]: Error: getaddrinfo -3007 Mar 24 19:22:37 smsl-n100 volumio[999]: at errnoException (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:199:11) Mar 24 19:22:37 smsl-n100 volumio[999]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:112:10) Mar 24 19:22:37 smsl-n100 volumio[999]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) { Mar 24 19:22:37 smsl-n100 volumio[999]: code: -3007, Mar 24 19:22:37 smsl-n100 volumio[999]: errno: -3007, Mar 24 19:22:37 smsl-n100 volumio[999]: syscall: 'getaddrinfo' Mar 24 19:22:37 smsl-n100 volumio[999]: } Mar 24 19:22:37 smsl-n100 volumio[999]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 24 19:22:38 smsl-n100 sudo[5861]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-03-24 19:21 Mar 24 19:22:38 smsl-n100 sudo[5861]: 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="cc50ad4a2058d01de272214eb33827883bd2b7d8" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="3441cddd43405c36fe444484553f10f2f5bc830b" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="smsl" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 13 Nov 2025 12:39:08 PM CET" VOLUMIO_VERSION="3.874" VOLUMIO_HARDWARE="nanopineo3" VOLUMIO_DEVICENAME="Nanopi Neo3" VOLUMIO_VENDOR_MODEL="SMSL S100" VOLUMIO_VENDOR="SMSL" VOLUMIO_MODEL="S100" VOLUMIO_HASH="7a92d73f7a04bc7854b1812143743fd4"