-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Thu 2025-05-29 09:04:05 CEST. --
May 29 09:03:02 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 29 09:03:06 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 29 09:03:10 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 29 09:03:10 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb
May 29 09:03:10 volumio volumio[3056]: verbose: ControllerMpd::sendMpdCommand update
May 29 09:03:10 volumio volumio[3056]: verbose: ControllerMpd::sendMpdCommand status
May 29 09:03:10 volumio volumio[3056]: info:
May 29 09:03:10 volumio volumio[3056]: ---------------------------- MPD announces state update: update
May 29 09:03:10 volumio volumio[3056]: info: sendMpdCommand update took 4 milliseconds
May 29 09:03:10 volumio volumio[3056]: info: ControllerMpd::getState
May 29 09:03:10 volumio volumio[3056]: verbose: ControllerMpd::sendMpdCommand status
May 29 09:03:10 volumio volumio[3056]: verbose: ControllerMpd::sendMpdCommand status
May 29 09:03:10 volumio volumio[3056]: info:
May 29 09:03:10 volumio volumio[3056]: ---------------------------- MPD announces state update: update
May 29 09:03:10 volumio volumio[3056]: info: ControllerMpd::getState
May 29 09:03:10 volumio volumio[3056]: verbose: ControllerMpd::sendMpdCommand status
May 29 09:03:10 volumio volumio[3056]: verbose: ControllerMpd::sendMpdCommand status
May 29 09:03:10 volumio volumio[3056]: info:
May 29 09:03:10 volumio volumio[3056]: ---------------------------- MPD announces state update: update
May 29 09:03:10 volumio volumio[3056]: info: ControllerMpd::getState
May 29 09:03:10 volumio volumio[3056]: verbose: ControllerMpd::sendMpdCommand status
May 29 09:03:10 volumio volumio[3056]: verbose: ControllerMpd::sendMpdCommand status
May 29 09:03:10 volumio volumio[3056]: info:
May 29 09:03:10 volumio volumio[3056]: ---------------------------- MPD announces state update: update
May 29 09:03:10 volumio volumio[3056]: info: ControllerMpd::getState
May 29 09:03:10 volumio volumio[3056]: verbose: ControllerMpd::sendMpdCommand status
May 29 09:03:10 volumio volumio[3056]: info: sendMpdCommand status took 9 milliseconds
May 29 09:03:10 volumio volumio[3056]: info: sendMpdCommand status took 7 milliseconds
May 29 09:03:10 volumio volumio[3056]: info: sendMpdCommand status took 6 milliseconds
May 29 09:03:10 volumio volumio[3056]: info: sendMpdCommand status took 5 milliseconds
May 29 09:03:10 volumio volumio[3056]: info: sendMpdCommand status took 5 milliseconds
May 29 09:03:10 volumio volumio[3056]: info: sendMpdCommand status took 4 milliseconds
May 29 09:03:10 volumio volumio[3056]: verbose: ControllerMpd::parseState
May 29 09:03:10 volumio volumio[3056]: info: Command Router : Notfying DB Updatefalse
May 29 09:03:10 volumio volumio[3056]: info: CoreCommandRouter::Close All Modals sent
May 29 09:03:10 volumio volumio[3056]: verbose: ControllerMpd::parseState
May 29 09:03:10 volumio volumio[3056]: verbose: ControllerMpd::parseState
May 29 09:03:10 volumio volumio[3056]: info: Command Router : Notfying DB Updatefalse
May 29 09:03:10 volumio volumio[3056]: info: CoreCommandRouter::Close All Modals sent
May 29 09:03:10 volumio volumio[3056]: verbose: ControllerMpd::parseState
May 29 09:03:10 volumio volumio[3056]: verbose: ControllerMpd::parseState
May 29 09:03:10 volumio volumio[3056]: info: Command Router : Notfying DB Updatefalse
May 29 09:03:10 volumio volumio[3056]: info: CoreCommandRouter::Close All Modals sent
May 29 09:03:10 volumio volumio[3056]: verbose: ControllerMpd::parseState
May 29 09:03:10 volumio volumio[3056]: info: ControllerMpd::pushState
May 29 09:03:10 volumio volumio[3056]: info: CoreCommandRouter::servicePushState
May 29 09:03:10 volumio volumio[3056]: info: CoreStateMachine::pushState
May 29 09:03:10 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 29 09:03:10 volumio volumio[3056]: info: CoreCommandRouter::volumioPushState
May 29 09:03:10 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 29 09:03:10 volumio volumio[3056]: 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 29 09:03:10 volumio volumio[3056]: verbose: CURRENT POSITION 0
May 29 09:03:10 volumio volumio[3056]: info: CoreStateMachine::syncState stateService stop
May 29 09:03:10 volumio volumio[3056]: info: CoreStateMachine::syncState currentStatus stop
May 29 09:03:10 volumio volumio[3056]: info: CoreStateMachine::pushState
May 29 09:03:10 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 29 09:03:10 volumio volumio[3056]: info: CoreCommandRouter::volumioPushState
May 29 09:03:10 volumio volumio[3056]: info: No code
May 29 09:03:10 volumio volumio[3056]: info: CoreStateMachine::pushState
May 29 09:03:10 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 29 09:03:10 volumio volumio[3056]: info: CoreCommandRouter::volumioPushState
May 29 09:03:10 volumio volumio[3056]: info: ControllerMpd::pushState
May 29 09:03:10 volumio volumio[3056]: info: CoreCommandRouter::servicePushState
May 29 09:03:10 volumio volumio[3056]: info: CoreStateMachine::pushState
May 29 09:03:10 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 29 09:03:10 volumio volumio[3056]: info: CoreCommandRouter::volumioPushState
May 29 09:03:10 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 29 09:03:10 volumio volumio[3056]: 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 29 09:03:10 volumio volumio[3056]: verbose: CURRENT POSITION 0
May 29 09:03:10 volumio volumio[3056]: info: CoreStateMachine::syncState stateService stop
May 29 09:03:10 volumio volumio[3056]: info: CoreStateMachine::syncState currentStatus stop
May 29 09:03:10 volumio volumio[3056]: info: CoreStateMachine::pushState
May 29 09:03:10 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 29 09:03:10 volumio volumio[3056]: info: CoreCommandRouter::volumioPushState
May 29 09:03:10 volumio volumio[3056]: info: No code
May 29 09:03:10 volumio volumio[3056]: info: CoreStateMachine::pushState
May 29 09:03:10 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 29 09:03:10 volumio volumio[3056]: info: CoreCommandRouter::volumioPushState
May 29 09:03:10 volumio volumio[3056]: info: ControllerMpd::pushState
May 29 09:03:10 volumio volumio[3056]: info: CoreCommandRouter::servicePushState
May 29 09:03:10 volumio volumio[3056]: info: CoreStateMachine::pushState
May 29 09:03:10 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 29 09:03:10 volumio volumio[3056]: info: CoreCommandRouter::volumioPushState
May 29 09:03:10 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 29 09:03:10 volumio volumio[3056]: 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 29 09:03:10 volumio volumio[3056]: verbose: CURRENT POSITION 0
May 29 09:03:10 volumio volumio[3056]: info: CoreStateMachine::syncState stateService stop
May 29 09:03:10 volumio volumio[3056]: info: CoreStateMachine::syncState currentStatus stop
May 29 09:03:10 volumio volumio[3056]: info: CoreStateMachine::pushState
May 29 09:03:10 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 29 09:03:10 volumio volumio[3056]: info: CoreCommandRouter::volumioPushState
May 29 09:03:10 volumio volumio[3056]: info: No code
May 29 09:03:10 volumio volumio[3056]: info: CoreStateMachine::pushState
May 29 09:03:10 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 29 09:03:10 volumio volumio[3056]: info: CoreCommandRouter::volumioPushState
May 29 09:03:10 volumio volumio[3056]: info: ------------------------------ 208ms
May 29 09:03:10 volumio volumio[3056]: info: ------------------------------ 206ms
May 29 09:03:10 volumio volumio[3056]: info: ------------------------------ 205ms
May 29 09:03:10 volumio volumio[3056]: verbose: ControllerMpd::sendMpdCommand status
May 29 09:03:10 volumio volumio[3056]: info:
May 29 09:03:10 volumio volumio[3056]: ---------------------------- MPD announces state update: update
May 29 09:03:10 volumio volumio[3056]: info: ControllerMpd::getState
May 29 09:03:10 volumio volumio[3056]: verbose: ControllerMpd::sendMpdCommand status
May 29 09:03:10 volumio volumio[3056]: verbose: ControllerMpd::sendMpdCommand status
May 29 09:03:10 volumio volumio[3056]: info:
May 29 09:03:10 volumio volumio[3056]: ---------------------------- MPD announces state update: update
May 29 09:03:10 volumio volumio[3056]: info: ControllerMpd::getState
May 29 09:03:10 volumio volumio[3056]: verbose: ControllerMpd::sendMpdCommand status
May 29 09:03:10 volumio volumio[3056]: info: sendMpdCommand status took 210 milliseconds
May 29 09:03:10 volumio volumio[3056]: info: sendMpdCommand status took 211 milliseconds
May 29 09:03:10 volumio volumio[3056]: info: sendMpdCommand status took 8 milliseconds
May 29 09:03:10 volumio volumio[3056]: info: sendMpdCommand status took 7 milliseconds
May 29 09:03:10 volumio volumio[3056]: info: sendMpdCommand status took 6 milliseconds
May 29 09:03:10 volumio volumio[3056]: info: sendMpdCommand status took 5 milliseconds
May 29 09:03:10 volumio volumio[3056]: verbose: ControllerMpd::parseState
May 29 09:03:10 volumio volumio[3056]: info: Command Router : Notfying DB Updatefalse
May 29 09:03:10 volumio volumio[3056]: info: CoreCommandRouter::Close All Modals sent
May 29 09:03:10 volumio volumio[3056]: verbose: ControllerMpd::parseState
May 29 09:03:10 volumio volumio[3056]: verbose: ControllerMpd::parseState
May 29 09:03:10 volumio volumio[3056]: info: Command Router : Notfying DB Updatefalse
May 29 09:03:10 volumio volumio[3056]: info: CoreCommandRouter::Close All Modals sent
May 29 09:03:10 volumio volumio[3056]: verbose: ControllerMpd::parseState
May 29 09:03:10 volumio volumio[3056]: verbose: ControllerMpd::parseState
May 29 09:03:10 volumio volumio[3056]: info: Command Router : Notfying DB Updatefalse
May 29 09:03:10 volumio volumio[3056]: info: CoreCommandRouter::Close All Modals sent
May 29 09:03:10 volumio volumio[3056]: verbose: ControllerMpd::parseState
May 29 09:03:10 volumio volumio[3056]: info: ControllerMpd::pushState
May 29 09:03:10 volumio volumio[3056]: info: CoreCommandRouter::servicePushState
May 29 09:03:10 volumio volumio[3056]: info: CoreStateMachine::pushState
May 29 09:03:10 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 29 09:03:10 volumio volumio[3056]: info: CoreCommandRouter::volumioPushState
May 29 09:03:10 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 29 09:03:10 volumio volumio[3056]: 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 29 09:03:10 volumio volumio[3056]: verbose: CURRENT POSITION 0
May 29 09:03:10 volumio volumio[3056]: info: CoreStateMachine::syncState stateService stop
May 29 09:03:10 volumio volumio[3056]: info: CoreStateMachine::syncState currentStatus stop
May 29 09:03:10 volumio volumio[3056]: info: CoreStateMachine::pushState
May 29 09:03:10 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 29 09:03:10 volumio volumio[3056]: info: CoreCommandRouter::volumioPushState
May 29 09:03:10 volumio volumio[3056]: info: No code
May 29 09:03:10 volumio volumio[3056]: info: CoreStateMachine::pushState
May 29 09:03:10 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 29 09:03:10 volumio volumio[3056]: info: CoreCommandRouter::volumioPushState
May 29 09:03:10 volumio volumio[3056]: info: ControllerMpd::pushState
May 29 09:03:10 volumio volumio[3056]: info: CoreCommandRouter::servicePushState
May 29 09:03:10 volumio volumio[3056]: info: CoreStateMachine::pushState
May 29 09:03:10 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 29 09:03:10 volumio volumio[3056]: info: CoreCommandRouter::volumioPushState
May 29 09:03:10 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 29 09:03:10 volumio volumio[3056]: 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 29 09:03:10 volumio volumio[3056]: verbose: CURRENT POSITION 0
May 29 09:03:10 volumio volumio[3056]: info: CoreStateMachine::syncState stateService stop
May 29 09:03:10 volumio volumio[3056]: info: CoreStateMachine::syncState currentStatus stop
May 29 09:03:10 volumio volumio[3056]: info: CoreStateMachine::pushState
May 29 09:03:10 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 29 09:03:10 volumio volumio[3056]: info: CoreCommandRouter::volumioPushState
May 29 09:03:10 volumio volumio[3056]: info: No code
May 29 09:03:10 volumio volumio[3056]: info: CoreStateMachine::pushState
May 29 09:03:10 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 29 09:03:10 volumio volumio[3056]: info: CoreCommandRouter::volumioPushState
May 29 09:03:10 volumio volumio[3056]: info: ControllerMpd::pushState
May 29 09:03:10 volumio volumio[3056]: info: CoreCommandRouter::servicePushState
May 29 09:03:10 volumio volumio[3056]: info: CoreStateMachine::pushState
May 29 09:03:10 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 29 09:03:10 volumio volumio[3056]: info: CoreCommandRouter::volumioPushState
May 29 09:03:10 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 29 09:03:10 volumio volumio[3056]: 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 29 09:03:10 volumio volumio[3056]: verbose: CURRENT POSITION 0
May 29 09:03:10 volumio volumio[3056]: info: CoreStateMachine::syncState stateService stop
May 29 09:03:10 volumio volumio[3056]: info: CoreStateMachine::syncState currentStatus stop
May 29 09:03:10 volumio volumio[3056]: info: CoreStateMachine::pushState
May 29 09:03:10 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 29 09:03:10 volumio volumio[3056]: info: CoreCommandRouter::volumioPushState
May 29 09:03:10 volumio volumio[3056]: info: No code
May 29 09:03:10 volumio volumio[3056]: info: CoreStateMachine::pushState
May 29 09:03:10 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 29 09:03:10 volumio volumio[3056]: info: CoreCommandRouter::volumioPushState
May 29 09:03:10 volumio volumio[3056]: info: ------------------------------ 373ms
May 29 09:03:10 volumio volumio[3056]: info: ------------------------------ 169ms
May 29 09:03:10 volumio volumio[3056]: info: ------------------------------ 168ms
May 29 09:03:14 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 29 09:03:18 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 29 09:03:22 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 29 09:03:24 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 29 09:03:24 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 29 09:03:24 volumio volumio[3056]: info: Discovery: Getting this device information
May 29 09:03:24 volumio volumio[3056]: info: CoreCommandRouter::volumioGetState
May 29 09:03:24 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 29 09:03:24 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 29 09:03:26 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 29 09:03:30 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 29 09:03:34 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 29 09:03:36 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: networkfs , editShare
May 29 09:03:36 volumio sudo[4465]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount /mnt/NAS/Musik
May 29 09:03:36 volumio sudo[4465]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 29 09:03:36 volumio systemd[1]: mnt-NAS-Musik.mount: Succeeded.
May 29 09:03:36 volumio sudo[4465]: pam_unix(sudo:session): session closed for user root
May 29 09:03:36 volumio volumio[3056]: info: Share Musik successfully unmounted
May 29 09:03:36 volumio sudo[4472]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=Volumio,password=QBVolumio*09,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=2.10 //192.168.178.36/Musik /mnt/NAS/Musik
May 29 09:03:36 volumio sudo[4472]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 29 09:03:36 volumio sudo[4472]: pam_unix(sudo:session): session closed for user root
May 29 09:03:36 volumio volumio[3056]: info: An error occurred mounting the new share. Rolling back configuration
May 29 09:03:36 volumio kernel: Key type cifs.spnego registered
May 29 09:03:36 volumio kernel: Key type cifs.idmap registered
May 29 09:03:36 volumio kernel: Unknown vers= option specified: 2.10
May 29 09:03:36 volumio kernel: CIFS: VFS: Unknown vers= option specified: 2.10
May 29 09:03:37 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
May 29 09:03:38 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 29 09:03:42 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 29 09:03:46 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 29 09:03:48 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: networkfs , editShare
May 29 09:03:48 volumio volumio[3056]: info: Share Musik successfully unmounted
May 29 09:03:48 volumio sudo[4522]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto,vers=2.10 192.168.178.36:Musik /mnt/NAS/Musik
May 29 09:03:48 volumio sudo[4522]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 29 09:03:48 volumio sudo[4522]: pam_unix(sudo:session): session closed for user root
May 29 09:03:48 volumio volumio[3056]: verbose: ControllerMpd::sendMpdCommand status
May 29 09:03:48 volumio volumio[3056]: info:
May 29 09:03:48 volumio volumio[3056]: ---------------------------- MPD announces state update: update
May 29 09:03:48 volumio volumio[3056]: info: ControllerMpd::getState
May 29 09:03:48 volumio volumio[3056]: verbose: ControllerMpd::sendMpdCommand status
May 29 09:03:48 volumio volumio[3056]: verbose: ControllerMpd::sendMpdCommand status
May 29 09:03:48 volumio volumio[3056]: info:
May 29 09:03:48 volumio volumio[3056]: ---------------------------- MPD announces state update: update
May 29 09:03:48 volumio volumio[3056]: info: ControllerMpd::getState
May 29 09:03:48 volumio volumio[3056]: verbose: ControllerMpd::sendMpdCommand status
May 29 09:03:48 volumio volumio[3056]: verbose: ControllerMpd::sendMpdCommand status
May 29 09:03:48 volumio volumio[3056]: info:
May 29 09:03:48 volumio volumio[3056]: ---------------------------- MPD announces state update: update
May 29 09:03:48 volumio volumio[3056]: info: ControllerMpd::getState
May 29 09:03:49 volumio volumio[3056]: verbose: ControllerMpd::sendMpdCommand status
May 29 09:03:49 volumio volumio[3056]: verbose: ControllerMpd::sendMpdCommand status
May 29 09:03:49 volumio volumio[3056]: info:
May 29 09:03:49 volumio volumio[3056]: ---------------------------- MPD announces state update: update
May 29 09:03:49 volumio volumio[3056]: info: sendMpdCommand status took 7 milliseconds
May 29 09:03:49 volumio volumio[3056]: info: ControllerMpd::getState
May 29 09:03:49 volumio volumio[3056]: verbose: ControllerMpd::sendMpdCommand status
May 29 09:03:49 volumio volumio[3056]: info: sendMpdCommand status took 8 milliseconds
May 29 09:03:49 volumio volumio[3056]: info: sendMpdCommand status took 7 milliseconds
May 29 09:03:49 volumio volumio[3056]: info: sendMpdCommand status took 6 milliseconds
May 29 09:03:49 volumio volumio[3056]: info: sendMpdCommand status took 5 milliseconds
May 29 09:03:49 volumio volumio[3056]: info: sendMpdCommand status took 4 milliseconds
May 29 09:03:49 volumio volumio[3056]: verbose: ControllerMpd::parseState
May 29 09:03:49 volumio volumio[3056]: info: Command Router : Notfying DB Updatetrue
May 29 09:03:49 volumio volumio[3056]: info: CoreCommandRouter::Close All Modals sent
May 29 09:03:49 volumio volumio[3056]: verbose: ControllerMpd::parseState
May 29 09:03:49 volumio volumio[3056]: verbose: ControllerMpd::parseState
May 29 09:03:49 volumio volumio[3056]: info: Command Router : Notfying DB Updatefalse
May 29 09:03:49 volumio volumio[3056]: info: CoreCommandRouter::Close All Modals sent
May 29 09:03:49 volumio volumio[3056]: verbose: ControllerMpd::parseState
May 29 09:03:49 volumio volumio[3056]: verbose: ControllerMpd::parseState
May 29 09:03:49 volumio volumio[3056]: info: Command Router : Notfying DB Updatefalse
May 29 09:03:49 volumio volumio[3056]: info: CoreCommandRouter::Close All Modals sent
May 29 09:03:49 volumio volumio[3056]: verbose: ControllerMpd::parseState
May 29 09:03:49 volumio volumio[3056]: info: ControllerMpd::pushState
May 29 09:03:49 volumio volumio[3056]: info: CoreCommandRouter::servicePushState
May 29 09:03:49 volumio volumio[3056]: info: CoreStateMachine::pushState
May 29 09:03:49 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 29 09:03:49 volumio volumio[3056]: info: CoreCommandRouter::volumioPushState
May 29 09:03:49 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 29 09:03:49 volumio volumio[3056]: 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 29 09:03:49 volumio volumio[3056]: verbose: CURRENT POSITION 0
May 29 09:03:49 volumio volumio[3056]: info: CoreStateMachine::syncState stateService stop
May 29 09:03:49 volumio volumio[3056]: info: CoreStateMachine::syncState currentStatus stop
May 29 09:03:49 volumio volumio[3056]: info: CoreStateMachine::pushState
May 29 09:03:49 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 29 09:03:49 volumio volumio[3056]: info: CoreCommandRouter::volumioPushState
May 29 09:03:49 volumio volumio[3056]: info: No code
May 29 09:03:49 volumio volumio[3056]: info: CoreStateMachine::pushState
May 29 09:03:49 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 29 09:03:49 volumio volumio[3056]: info: CoreCommandRouter::volumioPushState
May 29 09:03:49 volumio volumio[3056]: info: ControllerMpd::pushState
May 29 09:03:49 volumio volumio[3056]: info: CoreCommandRouter::servicePushState
May 29 09:03:49 volumio volumio[3056]: info: CoreStateMachine::pushState
May 29 09:03:49 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 29 09:03:49 volumio volumio[3056]: info: CoreCommandRouter::volumioPushState
May 29 09:03:49 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 29 09:03:49 volumio volumio[3056]: 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 29 09:03:49 volumio volumio[3056]: verbose: CURRENT POSITION 0
May 29 09:03:49 volumio volumio[3056]: info: CoreStateMachine::syncState stateService stop
May 29 09:03:49 volumio volumio[3056]: info: CoreStateMachine::syncState currentStatus stop
May 29 09:03:49 volumio volumio[3056]: info: CoreStateMachine::pushState
May 29 09:03:49 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 29 09:03:49 volumio volumio[3056]: info: CoreCommandRouter::volumioPushState
May 29 09:03:49 volumio volumio[3056]: info: No code
May 29 09:03:49 volumio volumio[3056]: info: CoreStateMachine::pushState
May 29 09:03:49 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 29 09:03:49 volumio volumio[3056]: info: CoreCommandRouter::volumioPushState
May 29 09:03:49 volumio volumio[3056]: info: ControllerMpd::pushState
May 29 09:03:49 volumio volumio[3056]: info: CoreCommandRouter::servicePushState
May 29 09:03:49 volumio volumio[3056]: info: CoreStateMachine::pushState
May 29 09:03:49 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 29 09:03:49 volumio volumio[3056]: info: CoreCommandRouter::volumioPushState
May 29 09:03:49 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 29 09:03:49 volumio volumio[3056]: 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 29 09:03:49 volumio volumio[3056]: verbose: CURRENT POSITION 0
May 29 09:03:49 volumio volumio[3056]: info: CoreStateMachine::syncState stateService stop
May 29 09:03:49 volumio volumio[3056]: info: CoreStateMachine::syncState currentStatus stop
May 29 09:03:49 volumio volumio[3056]: info: CoreStateMachine::pushState
May 29 09:03:49 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 29 09:03:49 volumio volumio[3056]: info: CoreCommandRouter::volumioPushState
May 29 09:03:49 volumio volumio[3056]: info: No code
May 29 09:03:49 volumio volumio[3056]: info: CoreStateMachine::pushState
May 29 09:03:49 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 29 09:03:49 volumio volumio[3056]: info: CoreCommandRouter::volumioPushState
May 29 09:03:49 volumio volumio[3056]: info: ------------------------------ 209ms
May 29 09:03:49 volumio volumio[3056]: info: ------------------------------ 208ms
May 29 09:03:49 volumio volumio[3056]: info: ------------------------------ 207ms
May 29 09:03:49 volumio volumio[3056]: verbose: ControllerMpd::sendMpdCommand status
May 29 09:03:49 volumio volumio[3056]: info:
May 29 09:03:49 volumio volumio[3056]: ---------------------------- MPD announces state update: update
May 29 09:03:49 volumio volumio[3056]: info: ControllerMpd::getState
May 29 09:03:49 volumio volumio[3056]: verbose: ControllerMpd::sendMpdCommand status
May 29 09:03:49 volumio volumio[3056]: verbose: ControllerMpd::sendMpdCommand status
May 29 09:03:49 volumio volumio[3056]: info:
May 29 09:03:49 volumio volumio[3056]: ---------------------------- MPD announces state update: update
May 29 09:03:49 volumio volumio[3056]: info: ControllerMpd::getState
May 29 09:03:49 volumio volumio[3056]: verbose: ControllerMpd::sendMpdCommand status
May 29 09:03:49 volumio volumio[3056]: info: [1748502229213] Database update started
May 29 09:03:49 volumio volumio[3056]: info: sendMpdCommand status took 221 milliseconds
May 29 09:03:49 volumio volumio[3056]: info: sendMpdCommand status took 220 milliseconds
May 29 09:03:49 volumio volumio[3056]: info: sendMpdCommand status took 15 milliseconds
May 29 09:03:49 volumio volumio[3056]: info: sendMpdCommand status took 14 milliseconds
May 29 09:03:49 volumio volumio[3056]: info: sendMpdCommand status took 13 milliseconds
May 29 09:03:49 volumio volumio[3056]: info: sendMpdCommand status took 13 milliseconds
May 29 09:03:49 volumio volumio[3056]: verbose: ControllerMpd::parseState
May 29 09:03:49 volumio volumio[3056]: info: Command Router : Notfying DB Updatefalse
May 29 09:03:49 volumio volumio[3056]: info: CoreCommandRouter::Close All Modals sent
May 29 09:03:49 volumio volumio[3056]: verbose: ControllerMpd::parseState
May 29 09:03:49 volumio volumio[3056]: verbose: ControllerMpd::parseState
May 29 09:03:49 volumio volumio[3056]: info: Command Router : Notfying DB Updatefalse
May 29 09:03:49 volumio volumio[3056]: info: CoreCommandRouter::Close All Modals sent
May 29 09:03:49 volumio volumio[3056]: verbose: ControllerMpd::parseState
May 29 09:03:49 volumio volumio[3056]: verbose: ControllerMpd::parseState
May 29 09:03:49 volumio volumio[3056]: info: Command Router : Notfying DB Updatefalse
May 29 09:03:49 volumio volumio[3056]: info: CoreCommandRouter::Close All Modals sent
May 29 09:03:49 volumio volumio[3056]: verbose: ControllerMpd::parseState
May 29 09:03:49 volumio volumio[3056]: info: ControllerMpd::pushState
May 29 09:03:49 volumio volumio[3056]: info: CoreCommandRouter::servicePushState
May 29 09:03:49 volumio volumio[3056]: info: CoreStateMachine::pushState
May 29 09:03:49 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 29 09:03:49 volumio volumio[3056]: info: CoreCommandRouter::volumioPushState
May 29 09:03:49 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 29 09:03:49 volumio volumio[3056]: 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 29 09:03:49 volumio volumio[3056]: verbose: CURRENT POSITION 0
May 29 09:03:49 volumio volumio[3056]: info: CoreStateMachine::syncState stateService stop
May 29 09:03:49 volumio volumio[3056]: info: CoreStateMachine::syncState currentStatus stop
May 29 09:03:49 volumio volumio[3056]: info: CoreStateMachine::pushState
May 29 09:03:49 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 29 09:03:49 volumio volumio[3056]: info: CoreCommandRouter::volumioPushState
May 29 09:03:49 volumio volumio[3056]: info: No code
May 29 09:03:49 volumio volumio[3056]: info: CoreStateMachine::pushState
May 29 09:03:49 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 29 09:03:49 volumio volumio[3056]: info: CoreCommandRouter::volumioPushState
May 29 09:03:49 volumio volumio[3056]: info: ControllerMpd::pushState
May 29 09:03:49 volumio volumio[3056]: info: CoreCommandRouter::servicePushState
May 29 09:03:49 volumio volumio[3056]: info: CoreStateMachine::pushState
May 29 09:03:49 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 29 09:03:49 volumio volumio[3056]: info: CoreCommandRouter::volumioPushState
May 29 09:03:49 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 29 09:03:49 volumio volumio[3056]: 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 29 09:03:49 volumio volumio[3056]: verbose: CURRENT POSITION 0
May 29 09:03:49 volumio volumio[3056]: info: CoreStateMachine::syncState stateService stop
May 29 09:03:49 volumio volumio[3056]: info: CoreStateMachine::syncState currentStatus stop
May 29 09:03:49 volumio volumio[3056]: info: CoreStateMachine::pushState
May 29 09:03:49 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 29 09:03:49 volumio volumio[3056]: info: CoreCommandRouter::volumioPushState
May 29 09:03:49 volumio volumio[3056]: info: No code
May 29 09:03:49 volumio volumio[3056]: info: CoreStateMachine::pushState
May 29 09:03:49 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 29 09:03:49 volumio volumio[3056]: info: CoreCommandRouter::volumioPushState
May 29 09:03:49 volumio volumio[3056]: info: ControllerMpd::pushState
May 29 09:03:49 volumio volumio[3056]: info: CoreCommandRouter::servicePushState
May 29 09:03:49 volumio volumio[3056]: info: CoreStateMachine::pushState
May 29 09:03:49 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 29 09:03:49 volumio volumio[3056]: info: CoreCommandRouter::volumioPushState
May 29 09:03:49 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 29 09:03:49 volumio volumio[3056]: 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 29 09:03:49 volumio volumio[3056]: verbose: CURRENT POSITION 0
May 29 09:03:49 volumio volumio[3056]: info: CoreStateMachine::syncState stateService stop
May 29 09:03:49 volumio volumio[3056]: info: CoreStateMachine::syncState currentStatus stop
May 29 09:03:49 volumio volumio[3056]: info: CoreStateMachine::pushState
May 29 09:03:49 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 29 09:03:49 volumio volumio[3056]: info: CoreCommandRouter::volumioPushState
May 29 09:03:49 volumio volumio[3056]: info: No code
May 29 09:03:49 volumio volumio[3056]: info: CoreStateMachine::pushState
May 29 09:03:49 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 29 09:03:49 volumio volumio[3056]: info: CoreCommandRouter::volumioPushState
May 29 09:03:49 volumio volumio[3056]: info: ------------------------------ 385ms
May 29 09:03:49 volumio volumio[3056]: info: ------------------------------ 180ms
May 29 09:03:49 volumio volumio[3056]: info: ------------------------------ 178ms
May 29 09:03:49 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
May 29 09:03:50 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 29 09:03:54 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 29 09:03:54 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 29 09:03:54 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 29 09:03:54 volumio volumio[3056]: info: Discovery: Getting this device information
May 29 09:03:54 volumio volumio[3056]: info: CoreCommandRouter::volumioGetState
May 29 09:03:54 volumio volumio[3056]: info: CorePlayQueue::getTrack 0
May 29 09:03:54 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 29 09:03:58 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 29 09:03:59 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares
May 29 09:03:59 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService
May 29 09:04:01 volumio volumio[3056]: info: Executing SMB command: smbclient --no-pass --debuglevel=0 -L fritz.box.
May 29 09:04:01 volumio volumio[3056]: info: Executing SMB command: smbclient --no-pass --debuglevel=0 -L fritz.box.
May 29 09:04:01 volumio volumio[3056]: info: Executing SMB command: smbclient --no-pass --debuglevel=0 -L NASMEIDIT.local.
May 29 09:04:01 volumio volumio[3056]: info: Error browsing device 192-168-178-1 for shares: Command failed: smbclient --no-pass --debuglevel=0 -L fritz.box.
May 29 09:04:01 volumio volumio[3056]: Unable to initialize messaging context
May 29 09:04:01 volumio volumio[3056]: info: Error browsing device fritz-box for shares: Command failed: smbclient --no-pass --debuglevel=0 -L fritz.box.
May 29 09:04:01 volumio volumio[3056]: Unable to initialize messaging context
May 29 09:04:02 volumio volumio[3056]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 29 09:04:04 volumio volumio[3056]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 29 09:04:04 volumio volumio[3056]: Error: dns service error: unknown
May 29 09:04:04 volumio volumio[3056]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30)
May 29 09:04:04 volumio volumio[3056]: at SocketWatcher.MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) {
May 29 09:04:04 volumio volumio[3056]: errorCode: -65537
May 29 09:04:04 volumio volumio[3056]: }
May 29 09:04:04 volumio volumio[3056]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 29 09:04:05 volumio sudo[4593]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-29 09:03
May 29 09:04:05 volumio sudo[4593]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="570c5791513f5bac7da274aba6690c1a961705de"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:16:30 PM CEST"
VOLUMIO_VERSION="3.812"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="3934ee440d5d3f0186049a23752ad680"