-- Logs begin at Wed 2025-05-14 14:05:27 UTC, end at Thu 2025-05-15 09:43:00 UTC. --
May 15 09:42:02 volumio volumio[6590]: info: CoreCommandRouter::getUIConfigOnPlugin
May 15 09:42:02 volumio volumio[6590]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
May 15 09:42:02 volumio volumio[6590]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
May 15 09:42:02 volumio volumio[6590]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs
May 15 09:42:02 volumio volumio[6590]: info: Received Get System Version
May 15 09:42:02 volumio volumio[6590]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 15 09:42:09 volumio volumio[6590]: info: CoreCommandRouter::volumioGetState
May 15 09:42:09 volumio volumio[6590]: info: CorePlayQueue::getTrack 39
May 15 09:42:15 volumio volumio[6590]: info: CoreCommandRouter::getUIConfigOnPlugin
May 15 09:42:15 volumio volumio[6590]: info: CoreCommandRouter::getUIConfigOnPlugin
May 15 09:42:15 volumio volumio[6590]: info: Retrieving Cloud Streaming UI
May 15 09:42:15 volumio volumio[6590]: info: Getting Tidal Cloud Configuration
May 15 09:42:15 volumio volumio[6590]: info: CoreCommandRouter::getUIConfigOnPlugin
May 15 09:42:15 volumio volumio[6590]: info: Getting Qobuz Cloud Configuration
May 15 09:42:15 volumio volumio[6590]: info: Asking plugin for UI Config
May 15 09:42:15 volumio volumio[6590]: info: CoreCommandRouter::getUIConfigOnPlugin
May 15 09:42:15 volumio volumio[6590]: info: Getting Spotify Cloud Configuration
May 15 09:42:15 volumio volumio[6590]: info: Asking plugin for UI Config
May 15 09:42:15 volumio volumio[6590]: info: CoreCommandRouter::getUIConfigOnPlugin
May 15 09:42:15 volumio volumio[6590]: info: Saving Spotify Acccount
May 15 09:42:15 volumio volumio[6590]: info: Got Tidal Cloud Configuration
May 15 09:42:15 volumio volumio[6590]: info: Got it
May 15 09:42:15 volumio volumio[6590]: info: Got it
May 15 09:42:15 volumio volumio[6590]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
May 15 09:42:15 volumio volumio[6590]: info: CoreCommandRouter::getUIConfigOnPlugin
May 15 09:42:15 volumio volumio[6590]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
May 15 09:42:15 volumio volumio[6590]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
May 15 09:42:15 volumio volumio[6590]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
May 15 09:42:15 volumio volumio[6590]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
May 15 09:42:15 volumio volumio[6590]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
May 15 09:42:15 volumio volumio[6590]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 15 09:42:15 volumio volumio[6590]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 15 09:42:15 volumio volumio[6590]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 15 09:42:15 volumio volumio[6590]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 15 09:42:15 volumio volumio[6590]: info: CoreCommandRouter::volumioGetBrowseSources
May 15 09:42:15 volumio volumio[6590]: info: CoreCommandRouter::volumioGetBrowseSources
May 15 09:42:15 volumio volumio[6590]: info: CoreCommandRouter::volumioGetBrowseSources
May 15 09:42:15 volumio volumio[6590]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 15 09:42:15 volumio volumio[6590]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
May 15 09:42:19 volumio volumio[6590]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb
May 15 09:42:19 volumio volumio[6590]: verbose: ControllerMpd::sendMpdCommand update
May 15 09:42:19 volumio volumio[6590]: verbose: ControllerMpd::sendMpdCommand status
May 15 09:42:19 volumio volumio[6590]: info:
May 15 09:42:19 volumio volumio[6590]: ---------------------------- MPD announces state update: update
May 15 09:42:19 volumio volumio[6590]: info: sendMpdCommand update took 6 milliseconds
May 15 09:42:19 volumio volumio[6590]: info: ControllerMpd::getState
May 15 09:42:19 volumio volumio[6590]: verbose: ControllerMpd::sendMpdCommand status
May 15 09:42:19 volumio volumio[6590]: verbose: ControllerMpd::sendMpdCommand status
May 15 09:42:19 volumio volumio[6590]: info:
May 15 09:42:19 volumio volumio[6590]: ---------------------------- MPD announces state update: update
May 15 09:42:19 volumio volumio[6590]: info: ControllerMpd::getState
May 15 09:42:19 volumio volumio[6590]: verbose: ControllerMpd::sendMpdCommand status
May 15 09:42:19 volumio volumio[6590]: verbose: ControllerMpd::sendMpdCommand status
May 15 09:42:19 volumio volumio[6590]: info:
May 15 09:42:19 volumio volumio[6590]: ---------------------------- MPD announces state update: update
May 15 09:42:19 volumio volumio[6590]: info: ControllerMpd::getState
May 15 09:42:19 volumio volumio[6590]: verbose: ControllerMpd::sendMpdCommand status
May 15 09:42:19 volumio volumio[6590]: info: sendMpdCommand status took 6 milliseconds
May 15 09:42:19 volumio volumio[6590]: info: sendMpdCommand status took 5 milliseconds
May 15 09:42:19 volumio volumio[6590]: info: sendMpdCommand status took 4 milliseconds
May 15 09:42:19 volumio volumio[6590]: info: sendMpdCommand status took 3 milliseconds
May 15 09:42:19 volumio volumio[6590]: info: sendMpdCommand status took 4 milliseconds
May 15 09:42:19 volumio volumio[6590]: info: sendMpdCommand status took 3 milliseconds
May 15 09:42:19 volumio volumio[6590]: verbose: ControllerMpd::parseState
May 15 09:42:19 volumio volumio[6590]: info: Command Router : Notfying DB Updatetrue
May 15 09:42:19 volumio volumio[6590]: verbose: ControllerMpd::parseState
May 15 09:42:19 volumio volumio[6590]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 15 09:42:19 volumio volumio[6590]: verbose: ControllerMpd::parseState
May 15 09:42:19 volumio volumio[6590]: info: Command Router : Notfying DB Updatetrue
May 15 09:42:19 volumio volumio[6590]: info: CoreCommandRouter::Close All Modals sent
May 15 09:42:19 volumio volumio[6590]: verbose: ControllerMpd::parseState
May 15 09:42:19 volumio volumio[6590]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 15 09:42:19 volumio volumio[6590]: verbose: ControllerMpd::parseState
May 15 09:42:19 volumio volumio[6590]: info: Command Router : Notfying DB Updatetrue
May 15 09:42:19 volumio volumio[6590]: info: CoreCommandRouter::Close All Modals sent
May 15 09:42:19 volumio volumio[6590]: verbose: ControllerMpd::parseState
May 15 09:42:19 volumio volumio[6590]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 15 09:42:19 volumio volumio[6590]: info: sendMpdCommand playlistinfo took 55 milliseconds
May 15 09:42:19 volumio volumio[6590]: info: sendMpdCommand playlistinfo took 27 milliseconds
May 15 09:42:19 volumio volumio[6590]: info: sendMpdCommand playlistinfo took 5 milliseconds
May 15 09:42:19 volumio volumio[6590]: verbose: ControllerMpd::parseTrackInfo
May 15 09:42:19 volumio volumio[6590]: verbose: ControllerMpd::parseTrackInfo
May 15 09:42:19 volumio volumio[6590]: info: ControllerMpd::pushState
May 15 09:42:19 volumio volumio[6590]: info: CoreCommandRouter::servicePushState
May 15 09:42:19 volumio volumio[6590]: info: CorePlayQueue::getTrack 39
May 15 09:42:19 volumio volumio[6590]: verbose: STATE SERVICE {"status":"play","position":0,"seek":99978,"duration":598,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Greensleeves","artist":"John Coltrane Quartet","album":"50 Sax Jazz Classics","uri":"NAS/Synology/50 Sax Jazz Classics 15/25. John Coltrane Quartet - Greensleeves.mp3","trackType":"mp3"}
May 15 09:42:19 volumio volumio[6590]: verbose: CURRENT POSITION 39
May 15 09:42:19 volumio volumio[6590]: info: CoreStateMachine::syncState stateService play
May 15 09:42:19 volumio volumio[6590]: info: CoreStateMachine::syncState currentStatus play
May 15 09:42:19 volumio volumio[6590]: info: Received an update from plugin. extracting info from payload
May 15 09:42:19 volumio volumio[6590]: info: CoreStateMachine::pushState
May 15 09:42:19 volumio volumio[6590]: info: CorePlayQueue::getTrack 39
May 15 09:42:19 volumio volumio[6590]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 15 09:42:19 volumio volumio[6590]: info: CoreCommandRouter::volumioPushState
May 15 09:42:19 volumio volumio[6590]: info: CoreStateMachine::pushState
May 15 09:42:19 volumio volumio[6590]: info: CorePlayQueue::getTrack 39
May 15 09:42:19 volumio volumio[6590]: info: CoreCommandRouter::volumioPushState
May 15 09:42:19 volumio volumio[6590]: info: ControllerMpd::pushState
May 15 09:42:19 volumio volumio[6590]: info: CoreCommandRouter::servicePushState
May 15 09:42:19 volumio volumio[6590]: info: CorePlayQueue::getTrack 39
May 15 09:42:19 volumio volumio[6590]: verbose: STATE SERVICE {"status":"play","position":0,"seek":99978,"duration":598,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Greensleeves","artist":"John Coltrane Quartet","album":"50 Sax Jazz Classics","uri":"NAS/Synology/50 Sax Jazz Classics 15/25. John Coltrane Quartet - Greensleeves.mp3","trackType":"mp3"}
May 15 09:42:19 volumio volumio[6590]: verbose: CURRENT POSITION 39
May 15 09:42:19 volumio volumio[6590]: info: CoreStateMachine::syncState stateService play
May 15 09:42:19 volumio volumio[6590]: info: CoreStateMachine::syncState currentStatus play
May 15 09:42:19 volumio volumio[6590]: info: Received an update from plugin. extracting info from payload
May 15 09:42:19 volumio volumio[6590]: info: CoreStateMachine::pushState
May 15 09:42:19 volumio volumio[6590]: info: CorePlayQueue::getTrack 39
May 15 09:42:19 volumio volumio[6590]: info: CoreCommandRouter::volumioPushState
May 15 09:42:19 volumio volumio[6590]: info: CoreStateMachine::pushState
May 15 09:42:19 volumio volumio[6590]: info: CorePlayQueue::getTrack 39
May 15 09:42:19 volumio volumio[6590]: info: CoreCommandRouter::volumioPushState
May 15 09:42:19 volumio volumio[6590]: info: ControllerMpd::pushState
May 15 09:42:19 volumio volumio[6590]: info: CoreCommandRouter::servicePushState
May 15 09:42:19 volumio volumio[6590]: info: CorePlayQueue::getTrack 39
May 15 09:42:19 volumio volumio[6590]: verbose: STATE SERVICE {"status":"play","position":0,"seek":99978,"duration":598,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Greensleeves","artist":"John Coltrane Quartet","album":"50 Sax Jazz Classics","uri":"NAS/Synology/50 Sax Jazz Classics 15/25. John Coltrane Quartet - Greensleeves.mp3","trackType":"mp3"}
May 15 09:42:19 volumio volumio[6590]: verbose: CURRENT POSITION 39
May 15 09:42:19 volumio volumio[6590]: info: CoreStateMachine::syncState stateService play
May 15 09:42:19 volumio volumio[6590]: info: CoreStateMachine::syncState currentStatus play
May 15 09:42:19 volumio volumio[6590]: info: Received an update from plugin. extracting info from payload
May 15 09:42:19 volumio volumio[6590]: info: CoreStateMachine::pushState
May 15 09:42:19 volumio volumio[6590]: info: CorePlayQueue::getTrack 39
May 15 09:42:19 volumio volumio[6590]: info: CoreCommandRouter::volumioPushState
May 15 09:42:19 volumio volumio[6590]: info: CoreStateMachine::pushState
May 15 09:42:19 volumio volumio[6590]: info: CorePlayQueue::getTrack 39
May 15 09:42:19 volumio volumio[6590]: info: CoreCommandRouter::volumioPushState
May 15 09:42:19 volumio volumio[6590]: info: ------------------------------ 114ms
May 15 09:42:19 volumio volumio[6590]: info: ------------------------------ 111ms
May 15 09:42:19 volumio volumio[6590]: info: ------------------------------ 110ms
May 15 09:42:19 volumio volumio[6590]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 15 09:42:19 volumio volumio[6590]: info: MPD Database updated - AlbumList cache refreshed
May 15 09:42:19 volumio volumio[6590]: info:
May 15 09:42:19 volumio volumio[6590]: ---------------------------- MPD announces state update: database
May 15 09:42:19 volumio volumio[6590]: verbose: ControllerMpd::sendMpdCommand status
May 15 09:42:19 volumio volumio[6590]: info:
May 15 09:42:19 volumio volumio[6590]: ---------------------------- MPD announces state update: update
May 15 09:42:19 volumio volumio[6590]: info: ControllerMpd::getState
May 15 09:42:19 volumio volumio[6590]: verbose: ControllerMpd::sendMpdCommand status
May 15 09:42:19 volumio volumio[6590]: info: ControllerMpd::getState
May 15 09:42:19 volumio volumio[6590]: verbose: ControllerMpd::sendMpdCommand status
May 15 09:42:19 volumio volumio[6590]: info: MPD Database updated - AlbumList cache refreshed
May 15 09:42:19 volumio volumio[6590]: info:
May 15 09:42:19 volumio volumio[6590]: ---------------------------- MPD announces state update: database
May 15 09:42:19 volumio volumio[6590]: verbose: ControllerMpd::sendMpdCommand status
May 15 09:42:19 volumio volumio[6590]: info:
May 15 09:42:19 volumio volumio[6590]: ---------------------------- MPD announces state update: update
May 15 09:42:19 volumio volumio[6590]: info: ControllerMpd::getState
May 15 09:42:19 volumio volumio[6590]: verbose: ControllerMpd::sendMpdCommand status
May 15 09:42:19 volumio volumio[6590]: info: ControllerMpd::getState
May 15 09:42:19 volumio volumio[6590]: verbose: ControllerMpd::sendMpdCommand status
May 15 09:42:19 volumio volumio[6590]: info: MPD Database updated - AlbumList cache refreshed
May 15 09:42:19 volumio volumio[6590]: info:
May 15 09:42:19 volumio volumio[6590]: ---------------------------- MPD announces state update: database
May 15 09:42:19 volumio volumio[6590]: verbose: ControllerMpd::sendMpdCommand status
May 15 09:42:19 volumio volumio[6590]: info:
May 15 09:42:19 volumio volumio[6590]: ---------------------------- MPD announces state update: update
May 15 09:42:19 volumio volumio[6590]: info: ControllerMpd::getState
May 15 09:42:19 volumio volumio[6590]: verbose: ControllerMpd::sendMpdCommand status
May 15 09:42:19 volumio volumio[6590]: info: ControllerMpd::getState
May 15 09:42:19 volumio volumio[6590]: verbose: ControllerMpd::sendMpdCommand status
May 15 09:42:19 volumio volumio[6590]: info: sendMpdCommand status took 50 milliseconds
May 15 09:42:19 volumio volumio[6590]: info: sendMpdCommand status took 51 milliseconds
May 15 09:42:19 volumio volumio[6590]: info: sendMpdCommand status took 50 milliseconds
May 15 09:42:19 volumio volumio[6590]: verbose: ControllerMpd::parseState
May 15 09:42:19 volumio volumio[6590]: info: Command Router : Notfying DB Updatefalse
May 15 09:42:19 volumio volumio[6590]: info: CoreCommandRouter::Close All Modals sent
May 15 09:42:19 volumio volumio[6590]: verbose: ControllerMpd::parseState
May 15 09:42:19 volumio volumio[6590]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 15 09:42:19 volumio volumio[6590]: verbose: ControllerMpd::parseState
May 15 09:42:19 volumio volumio[6590]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 15 09:42:19 volumio volumio[6590]: info: sendMpdCommand status took 105 milliseconds
May 15 09:42:19 volumio volumio[6590]: info: sendMpdCommand status took 105 milliseconds
May 15 09:42:19 volumio volumio[6590]: info: sendMpdCommand status took 104 milliseconds
May 15 09:42:19 volumio volumio[6590]: verbose: ControllerMpd::parseState
May 15 09:42:19 volumio volumio[6590]: info: Command Router : Notfying DB Updatefalse
May 15 09:42:19 volumio volumio[6590]: info: CoreCommandRouter::Close All Modals sent
May 15 09:42:19 volumio volumio[6590]: verbose: ControllerMpd::parseState
May 15 09:42:19 volumio volumio[6590]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 15 09:42:19 volumio volumio[6590]: verbose: ControllerMpd::parseState
May 15 09:42:19 volumio volumio[6590]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 15 09:42:19 volumio volumio[6590]: info: sendMpdCommand status took 169 milliseconds
May 15 09:42:19 volumio volumio[6590]: info: sendMpdCommand status took 168 milliseconds
May 15 09:42:19 volumio volumio[6590]: info: sendMpdCommand status took 168 milliseconds
May 15 09:42:19 volumio volumio[6590]: info: sendMpdCommand playlistinfo took 96 milliseconds
May 15 09:42:19 volumio volumio[6590]: info: sendMpdCommand playlistinfo took 96 milliseconds
May 15 09:42:19 volumio volumio[6590]: verbose: ControllerMpd::parseState
May 15 09:42:19 volumio volumio[6590]: info: Command Router : Notfying DB Updatefalse
May 15 09:42:19 volumio volumio[6590]: info: CoreCommandRouter::Close All Modals sent
May 15 09:42:19 volumio volumio[6590]: verbose: ControllerMpd::parseState
May 15 09:42:19 volumio volumio[6590]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 15 09:42:19 volumio volumio[6590]: verbose: ControllerMpd::parseState
May 15 09:42:19 volumio volumio[6590]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 15 09:42:19 volumio volumio[6590]: verbose: ControllerMpd::parseTrackInfo
May 15 09:42:19 volumio volumio[6590]: info: ControllerMpd::pushState
May 15 09:42:19 volumio volumio[6590]: info: CoreCommandRouter::servicePushState
May 15 09:42:19 volumio volumio[6590]: info: CorePlayQueue::getTrack 39
May 15 09:42:19 volumio volumio[6590]: verbose: STATE SERVICE {"status":"play","position":0,"seek":100479,"duration":598,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Greensleeves","artist":"John Coltrane Quartet","album":"50 Sax Jazz Classics","uri":"NAS/Synology/50 Sax Jazz Classics 15/25. John Coltrane Quartet - Greensleeves.mp3","trackType":"mp3"}
May 15 09:42:19 volumio volumio[6590]: verbose: CURRENT POSITION 39
May 15 09:42:19 volumio volumio[6590]: info: CoreStateMachine::syncState stateService play
May 15 09:42:19 volumio volumio[6590]: info: CoreStateMachine::syncState currentStatus play
May 15 09:42:19 volumio volumio[6590]: info: Received an update from plugin. extracting info from payload
May 15 09:42:19 volumio volumio[6590]: info: CoreStateMachine::pushState
May 15 09:42:19 volumio volumio[6590]: info: CorePlayQueue::getTrack 39
May 15 09:42:19 volumio volumio[6590]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 15 09:42:19 volumio volumio[6590]: info: CoreCommandRouter::volumioPushState
May 15 09:42:19 volumio volumio[6590]: info: CoreStateMachine::pushState
May 15 09:42:19 volumio volumio[6590]: info: CorePlayQueue::getTrack 39
May 15 09:42:19 volumio volumio[6590]: info: CoreCommandRouter::volumioPushState
May 15 09:42:19 volumio volumio[6590]: info: ControllerMpd::pushState
May 15 09:42:19 volumio volumio[6590]: info: CoreCommandRouter::servicePushState
May 15 09:42:19 volumio volumio[6590]: info: CorePlayQueue::getTrack 39
May 15 09:42:19 volumio volumio[6590]: verbose: STATE SERVICE {"status":"play","position":0,"seek":100479,"duration":598,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Greensleeves","artist":"John Coltrane Quartet","album":"50 Sax Jazz Classics","uri":"NAS/Synology/50 Sax Jazz Classics 15/25. John Coltrane Quartet - Greensleeves.mp3","trackType":"mp3"}
May 15 09:42:19 volumio volumio[6590]: verbose: CURRENT POSITION 39
May 15 09:42:19 volumio volumio[6590]: info: CoreStateMachine::syncState stateService play
May 15 09:42:19 volumio volumio[6590]: info: CoreStateMachine::syncState currentStatus play
May 15 09:42:19 volumio volumio[6590]: info: Received an update from plugin. extracting info from payload
May 15 09:42:19 volumio volumio[6590]: info: CoreStateMachine::pushState
May 15 09:42:19 volumio volumio[6590]: info: CorePlayQueue::getTrack 39
May 15 09:42:19 volumio volumio[6590]: info: CoreCommandRouter::volumioPushState
May 15 09:42:19 volumio volumio[6590]: info: CoreStateMachine::pushState
May 15 09:42:19 volumio volumio[6590]: info: CorePlayQueue::getTrack 39
May 15 09:42:19 volumio volumio[6590]: info: CoreCommandRouter::volumioPushState
May 15 09:42:19 volumio volumio[6590]: info: ------------------------------ 208ms
May 15 09:42:19 volumio volumio[6590]: info: ------------------------------ 208ms
May 15 09:42:19 volumio volumio[6590]: info: sendMpdCommand playlistinfo took 79 milliseconds
May 15 09:42:19 volumio volumio[6590]: info: sendMpdCommand playlistinfo took 79 milliseconds
May 15 09:42:19 volumio volumio[6590]: info: sendMpdCommand playlistinfo took 16 milliseconds
May 15 09:42:19 volumio volumio[6590]: info: sendMpdCommand playlistinfo took 16 milliseconds
May 15 09:42:19 volumio volumio[6590]: verbose: ControllerMpd::parseTrackInfo
May 15 09:42:19 volumio volumio[6590]: verbose: ControllerMpd::parseTrackInfo
May 15 09:42:19 volumio volumio[6590]: verbose: ControllerMpd::parseTrackInfo
May 15 09:42:19 volumio volumio[6590]: verbose: ControllerMpd::parseTrackInfo
May 15 09:42:19 volumio volumio[6590]: info: ControllerMpd::pushState
May 15 09:42:19 volumio volumio[6590]: info: CoreCommandRouter::servicePushState
May 15 09:42:19 volumio volumio[6590]: info: CorePlayQueue::getTrack 39
May 15 09:42:19 volumio volumio[6590]: verbose: STATE SERVICE {"status":"play","position":0,"seek":100479,"duration":598,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Greensleeves","artist":"John Coltrane Quartet","album":"50 Sax Jazz Classics","uri":"NAS/Synology/50 Sax Jazz Classics 15/25. John Coltrane Quartet - Greensleeves.mp3","trackType":"mp3"}
May 15 09:42:19 volumio volumio[6590]: verbose: CURRENT POSITION 39
May 15 09:42:19 volumio volumio[6590]: info: CoreStateMachine::syncState stateService play
May 15 09:42:19 volumio volumio[6590]: info: CoreStateMachine::syncState currentStatus play
May 15 09:42:19 volumio volumio[6590]: info: Received an update from plugin. extracting info from payload
May 15 09:42:19 volumio volumio[6590]: info: CoreStateMachine::pushState
May 15 09:42:19 volumio volumio[6590]: info: CorePlayQueue::getTrack 39
May 15 09:42:19 volumio volumio[6590]: info: CoreCommandRouter::volumioPushState
May 15 09:42:19 volumio volumio[6590]: info: CoreStateMachine::pushState
May 15 09:42:19 volumio volumio[6590]: info: CorePlayQueue::getTrack 39
May 15 09:42:19 volumio volumio[6590]: info: CoreCommandRouter::volumioPushState
May 15 09:42:19 volumio volumio[6590]: info: ControllerMpd::pushState
May 15 09:42:19 volumio volumio[6590]: info: CoreCommandRouter::servicePushState
May 15 09:42:19 volumio volumio[6590]: info: CorePlayQueue::getTrack 39
May 15 09:42:19 volumio volumio[6590]: verbose: STATE SERVICE {"status":"play","position":0,"seek":100479,"duration":598,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Greensleeves","artist":"John Coltrane Quartet","album":"50 Sax Jazz Classics","uri":"NAS/Synology/50 Sax Jazz Classics 15/25. John Coltrane Quartet - Greensleeves.mp3","trackType":"mp3"}
May 15 09:42:19 volumio volumio[6590]: verbose: CURRENT POSITION 39
May 15 09:42:19 volumio volumio[6590]: info: CoreStateMachine::syncState stateService play
May 15 09:42:19 volumio volumio[6590]: info: CoreStateMachine::syncState currentStatus play
May 15 09:42:19 volumio volumio[6590]: info: Received an update from plugin. extracting info from payload
May 15 09:42:19 volumio volumio[6590]: info: CoreStateMachine::pushState
May 15 09:42:19 volumio volumio[6590]: info: CorePlayQueue::getTrack 39
May 15 09:42:19 volumio volumio[6590]: info: CoreCommandRouter::volumioPushState
May 15 09:42:19 volumio volumio[6590]: info: CoreStateMachine::pushState
May 15 09:42:19 volumio volumio[6590]: info: CorePlayQueue::getTrack 39
May 15 09:42:19 volumio volumio[6590]: info: CoreCommandRouter::volumioPushState
May 15 09:42:19 volumio volumio[6590]: info: ControllerMpd::pushState
May 15 09:42:19 volumio volumio[6590]: info: CoreCommandRouter::servicePushState
May 15 09:42:19 volumio volumio[6590]: info: CorePlayQueue::getTrack 39
May 15 09:42:19 volumio volumio[6590]: verbose: STATE SERVICE {"status":"play","position":0,"seek":100479,"duration":598,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Greensleeves","artist":"John Coltrane Quartet","album":"50 Sax Jazz Classics","uri":"NAS/Synology/50 Sax Jazz Classics 15/25. John Coltrane Quartet - Greensleeves.mp3","trackType":"mp3"}
May 15 09:42:19 volumio volumio[6590]: verbose: CURRENT POSITION 39
May 15 09:42:19 volumio volumio[6590]: info: CoreStateMachine::syncState stateService play
May 15 09:42:19 volumio volumio[6590]: info: CoreStateMachine::syncState currentStatus play
May 15 09:42:19 volumio volumio[6590]: info: Received an update from plugin. extracting info from payload
May 15 09:42:19 volumio volumio[6590]: info: CoreStateMachine::pushState
May 15 09:42:19 volumio volumio[6590]: info: CorePlayQueue::getTrack 39
May 15 09:42:19 volumio volumio[6590]: info: CoreCommandRouter::volumioPushState
May 15 09:42:19 volumio volumio[6590]: info: CoreStateMachine::pushState
May 15 09:42:19 volumio volumio[6590]: info: CorePlayQueue::getTrack 39
May 15 09:42:19 volumio volumio[6590]: info: CoreCommandRouter::volumioPushState
May 15 09:42:19 volumio volumio[6590]: info: ControllerMpd::pushState
May 15 09:42:19 volumio volumio[6590]: info: CoreCommandRouter::servicePushState
May 15 09:42:20 volumio volumio[6590]: info: CorePlayQueue::getTrack 39
May 15 09:42:20 volumio volumio[6590]: verbose: STATE SERVICE {"status":"play","position":0,"seek":100479,"duration":598,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Greensleeves","artist":"John Coltrane Quartet","album":"50 Sax Jazz Classics","uri":"NAS/Synology/50 Sax Jazz Classics 15/25. John Coltrane Quartet - Greensleeves.mp3","trackType":"mp3"}
May 15 09:42:20 volumio volumio[6590]: verbose: CURRENT POSITION 39
May 15 09:42:20 volumio volumio[6590]: info: CoreStateMachine::syncState stateService play
May 15 09:42:20 volumio volumio[6590]: info: CoreStateMachine::syncState currentStatus play
May 15 09:42:20 volumio volumio[6590]: info: Received an update from plugin. extracting info from payload
May 15 09:42:20 volumio volumio[6590]: info: CoreStateMachine::pushState
May 15 09:42:20 volumio volumio[6590]: info: CorePlayQueue::getTrack 39
May 15 09:42:20 volumio volumio[6590]: info: CoreCommandRouter::volumioPushState
May 15 09:42:20 volumio volumio[6590]: info: CoreStateMachine::pushState
May 15 09:42:20 volumio volumio[6590]: info: CorePlayQueue::getTrack 39
May 15 09:42:20 volumio volumio[6590]: info: CoreCommandRouter::volumioPushState
May 15 09:42:20 volumio volumio[6590]: info: ------------------------------ 228ms
May 15 09:42:20 volumio volumio[6590]: info: ------------------------------ 228ms
May 15 09:42:20 volumio volumio[6590]: info: ------------------------------ 227ms
May 15 09:42:20 volumio volumio[6590]: info: ------------------------------ 227ms
May 15 09:42:23 volumio volumio[6590]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 15 09:42:27 volumio volumio[6590]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 15 09:42:31 volumio volumio[6590]: info: CoreCommandRouter::volumioGetState
May 15 09:42:31 volumio volumio[6590]: info: CorePlayQueue::getTrack 39
May 15 09:42:36 volumio volumio[6590]: info: CoreCommandRouter::volumioGetState
May 15 09:42:36 volumio volumio[6590]: info: CorePlayQueue::getTrack 39
May 15 09:42:47 volumio volumio[6590]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
May 15 09:42:47 volumio volumio[6590]: info: Preload queue cleared
May 15 09:42:50 volumio volumio[6590]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
May 15 09:42:50 volumio volumio[6590]: info: Preload queue cleared
May 15 09:42:51 volumio volumio[6590]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
May 15 09:42:51 volumio volumio[6590]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
May 15 09:42:52 volumio volumio[6590]: info: Preload queue cleared
May 15 09:42:52 volumio volumio[6590]: info: Preload queue cleared
May 15 09:42:59 volumio volumio[6590]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
May 15 09:42:59 volumio volumio[6590]: info: Preload queue cleared
May 15 09:42:59 volumio volumio[6590]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
May 15 09:43:00 volumio volumio[6590]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 15 09:43:00 volumio volumio[6590]: TypeError: Cannot read property 'length' of undefined
May 15 09:43:00 volumio volumio[6590]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25
May 15 09:43:00 volumio volumio[6590]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13
May 15 09:43:00 volumio volumio[6590]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18)
May 15 09:43:00 volumio volumio[6590]: at Parser.emit (events.js:400:28)
May 15 09:43:00 volumio volumio[6590]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26)
May 15 09:43:00 volumio volumio[6590]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35)
May 15 09:43:00 volumio volumio[6590]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5)
May 15 09:43:00 volumio volumio[6590]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7)
May 15 09:43:00 volumio volumio[6590]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13)
May 15 09:43:00 volumio volumio[6590]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31)
May 15 09:43:00 volumio volumio[6590]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59)
May 15 09:43:00 volumio volumio[6590]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19)
May 15 09:43:00 volumio volumio[6590]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15)
May 15 09:43:00 volumio volumio[6590]: at IncomingMessage.emit (events.js:412:35)
May 15 09:43:00 volumio volumio[6590]: at endReadableNT (internal/streams/readable.js:1333:12)
May 15 09:43:00 volumio volumio[6590]: at processTicksAndRejections (internal/process/task_queues.js:82:21)
May 15 09:43:00 volumio volumio[6590]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 15 09:43:00 volumio sudo[18962]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-15 09:42
May 15 09:43:00 volumio sudo[18962]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Debian GNU/Linux 10 (buster)"
NAME="Debian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=debian
HOME_URL="https://www.debian.org/"
SUPPORT_URL="https://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
VOLUMIO_BUILD_VERSION="147953990fca4aa103a8f90538ef56fb0454638c"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="9ab87de061b3649c303da550e73c92d340b0f989"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed 30 Apr 2025 12:21:23 PM CEST"
VOLUMIO_VERSION="3.807"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="a9588e47e4b05f1a05bf70b4acc7555c"