-- Logs begin at Wed 2024-08-28 14:22:39 JST, end at Wed 2024-08-28 14:52:12 JST. -- Aug 28 14:51:01 bb1129 volumio[3311]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 28 14:51:05 bb1129 volumio[3311]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 28 14:51:06 bb1129 volumio[3311]: info: CoreCommandRouter::volumioGetState Aug 28 14:51:06 bb1129 volumio[3311]: info: CorePlayQueue::getTrack 0 Aug 28 14:51:06 bb1129 volumio[3311]: info: Listing playlists Aug 28 14:51:06 bb1129 volumio[3311]: info: Listing playlists Aug 28 14:51:09 bb1129 volumio[3311]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 28 14:51:13 bb1129 volumio[3311]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 28 14:51:16 bb1129 volumio[3311]: info: CoreCommandRouter::volumioGetState Aug 28 14:51:16 bb1129 volumio[3311]: info: CorePlayQueue::getTrack 0 Aug 28 14:51:17 bb1129 volumio[3311]: info: Error browsing device 庭 for shares : Error: Command failed: echo volumio | smbclient -L linux.local. Aug 28 14:51:17 bb1129 volumio[3311]: Unable to initialize messaging context Aug 28 14:51:17 bb1129 volumio[3311]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 28 14:51:21 bb1129 volumio[3311]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 28 14:51:25 bb1129 volumio[3311]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 28 14:51:26 bb1129 volumio[3311]: info: CoreCommandRouter::volumioGetState Aug 28 14:51:26 bb1129 volumio[3311]: info: CorePlayQueue::getTrack 0 Aug 28 14:51:26 bb1129 volumio[3311]: info: Listing playlists Aug 28 14:51:26 bb1129 volumio[3311]: info: Listing playlists Aug 28 14:51:29 bb1129 volumio[3311]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 28 14:51:30 bb1129 nmbd[825]: [2024/08/28 14:51:30.318706, 0] ../source3/libsmb/nmblib.c:917(send_udp) Aug 28 14:51:30 bb1129 nmbd[825]: Packet send failed to 192.168.211.255(138) ERRNO=Network is unreachable Aug 28 14:51:33 bb1129 volumio[3311]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 28 14:51:36 bb1129 volumio[3311]: info: CoreCommandRouter::volumioGetState Aug 28 14:51:36 bb1129 volumio[3311]: info: CorePlayQueue::getTrack 0 Aug 28 14:51:37 bb1129 volumio[3311]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 28 14:51:41 bb1129 volumio[3311]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 28 14:51:45 bb1129 volumio[3311]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 28 14:51:46 bb1129 volumio[3311]: info: CoreCommandRouter::volumioGetState Aug 28 14:51:46 bb1129 volumio[3311]: info: CorePlayQueue::getTrack 0 Aug 28 14:51:46 bb1129 volumio[3311]: info: Listing playlists Aug 28 14:51:46 bb1129 volumio[3311]: info: Listing playlists Aug 28 14:51:50 bb1129 volumio[3311]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 28 14:51:53 bb1129 volumio[3311]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 28 14:51:55 bb1129 volumio[3311]: info: CoreCommandRouter::executeOnPlugin: networkfs , addShare Aug 28 14:51:55 bb1129 volumio[3311]: info: Adding a new share Aug 28 14:51:55 bb1129 volumio[3311]: info: No correspondence found in configuration for share Music on IP 192.168.0.34 Aug 28 14:51:55 bb1129 sudo[4216]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto 192.168.0.34:/BLACKEY.local /mnt/NAS/Music Aug 28 14:51:55 bb1129 sudo[4216]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 28 14:51:55 bb1129 kernel: FS-Cache: Loaded Aug 28 14:51:56 bb1129 kernel: Key type dns_resolver registered Aug 28 14:51:56 bb1129 kernel: NFS: Registering the id_resolver key type Aug 28 14:51:56 bb1129 kernel: Key type id_resolver registered Aug 28 14:51:56 bb1129 kernel: Key type id_legacy registered Aug 28 14:51:56 bb1129 volumio[3311]: info: CoreCommandRouter::volumioGetState Aug 28 14:51:56 bb1129 volumio[3311]: info: CorePlayQueue::getTrack 0 Aug 28 14:51:57 bb1129 volumio[3311]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 28 14:52:01 bb1129 volumio[3311]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Aug 28 14:52:02 bb1129 volumio[3311]: verbose: ControllerMpd::sendMpdCommand rescan Aug 28 14:52:02 bb1129 volumio[3311]: info: sendMpdCommand rescan took 3 milliseconds Aug 28 14:52:02 bb1129 volumio[3311]: verbose: ControllerMpd::sendMpdCommand status Aug 28 14:52:02 bb1129 volumio[3311]: info: Aug 28 14:52:02 bb1129 volumio[3311]: ---------------------------- MPD announces state update: update Aug 28 14:52:02 bb1129 volumio[3311]: info: ControllerMpd::getState Aug 28 14:52:02 bb1129 volumio[3311]: verbose: ControllerMpd::sendMpdCommand status Aug 28 14:52:02 bb1129 volumio[3311]: info: Aug 28 14:52:02 bb1129 volumio[3311]: ---------------------------- MPD announces state update: update Aug 28 14:52:02 bb1129 volumio[3311]: info: ControllerMpd::getState Aug 28 14:52:02 bb1129 volumio[3311]: verbose: ControllerMpd::sendMpdCommand status Aug 28 14:52:02 bb1129 volumio[3311]: verbose: ControllerMpd::sendMpdCommand status Aug 28 14:52:02 bb1129 volumio[3311]: info: Aug 28 14:52:02 bb1129 volumio[3311]: ---------------------------- MPD announces state update: update Aug 28 14:52:02 bb1129 volumio[3311]: info: ControllerMpd::getState Aug 28 14:52:02 bb1129 volumio[3311]: verbose: ControllerMpd::sendMpdCommand status Aug 28 14:52:02 bb1129 volumio[3311]: info: sendMpdCommand status took 10 milliseconds Aug 28 14:52:02 bb1129 volumio[3311]: info: sendMpdCommand status took 7 milliseconds Aug 28 14:52:02 bb1129 volumio[3311]: info: sendMpdCommand status took 7 milliseconds Aug 28 14:52:02 bb1129 volumio[3311]: info: sendMpdCommand status took 6 milliseconds Aug 28 14:52:02 bb1129 volumio[3311]: verbose: ControllerMpd::parseState Aug 28 14:52:02 bb1129 volumio[3311]: info: Command Router : Notfying DB Updatetrue Aug 28 14:52:02 bb1129 volumio[3311]: verbose: ControllerMpd::parseState Aug 28 14:52:02 bb1129 volumio[3311]: verbose: ControllerMpd::parseState Aug 28 14:52:02 bb1129 volumio[3311]: info: Command Router : Notfying DB Updatetrue Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreCommandRouter::Close All Modals sent Aug 28 14:52:02 bb1129 volumio[3311]: verbose: ControllerMpd::parseState Aug 28 14:52:02 bb1129 volumio[3311]: info: ControllerMpd::pushState Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreCommandRouter::servicePushState Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreStateMachine::pushState Aug 28 14:52:02 bb1129 volumio[3311]: info: CorePlayQueue::getTrack 0 Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreCommandRouter::volumioPushState Aug 28 14:52:02 bb1129 volumio[3311]: info: CorePlayQueue::getTrack 0 Aug 28 14:52:02 bb1129 volumio[3311]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 28 14:52:02 bb1129 volumio[3311]: verbose: CURRENT POSITION 0 Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreStateMachine::syncState stateService stop Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreStateMachine::syncState currentStatus stop Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreStateMachine::pushState Aug 28 14:52:02 bb1129 volumio[3311]: info: CorePlayQueue::getTrack 0 Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreCommandRouter::volumioPushState Aug 28 14:52:02 bb1129 volumio[3311]: info: No code Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreStateMachine::pushState Aug 28 14:52:02 bb1129 volumio[3311]: info: CorePlayQueue::getTrack 0 Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreCommandRouter::volumioPushState Aug 28 14:52:02 bb1129 volumio[3311]: info: ControllerMpd::pushState Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreCommandRouter::servicePushState Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreStateMachine::pushState Aug 28 14:52:02 bb1129 volumio[3311]: info: CorePlayQueue::getTrack 0 Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreCommandRouter::volumioPushState Aug 28 14:52:02 bb1129 volumio[3311]: info: CorePlayQueue::getTrack 0 Aug 28 14:52:02 bb1129 volumio[3311]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 28 14:52:02 bb1129 volumio[3311]: verbose: CURRENT POSITION 0 Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreStateMachine::syncState stateService stop Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreStateMachine::syncState currentStatus stop Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreStateMachine::pushState Aug 28 14:52:02 bb1129 volumio[3311]: info: CorePlayQueue::getTrack 0 Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreCommandRouter::volumioPushState Aug 28 14:52:02 bb1129 volumio[3311]: info: No code Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreStateMachine::pushState Aug 28 14:52:02 bb1129 volumio[3311]: info: CorePlayQueue::getTrack 0 Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreCommandRouter::volumioPushState Aug 28 14:52:02 bb1129 volumio[3311]: info: ------------------------------ 412ms Aug 28 14:52:02 bb1129 volumio[3311]: info: ------------------------------ 409ms Aug 28 14:52:02 bb1129 volumio[3311]: verbose: ControllerMpd::sendMpdCommand status Aug 28 14:52:02 bb1129 volumio[3311]: info: Aug 28 14:52:02 bb1129 volumio[3311]: ---------------------------- MPD announces state update: update Aug 28 14:52:02 bb1129 volumio[3311]: info: sendMpdCommand status took 413 milliseconds Aug 28 14:52:02 bb1129 volumio[3311]: info: sendMpdCommand status took 413 milliseconds Aug 28 14:52:02 bb1129 volumio[3311]: info: ControllerMpd::getState Aug 28 14:52:02 bb1129 volumio[3311]: verbose: ControllerMpd::sendMpdCommand status Aug 28 14:52:02 bb1129 volumio[3311]: verbose: ControllerMpd::parseState Aug 28 14:52:02 bb1129 volumio[3311]: info: Command Router : Notfying DB Updatetrue Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreCommandRouter::Close All Modals sent Aug 28 14:52:02 bb1129 volumio[3311]: verbose: ControllerMpd::parseState Aug 28 14:52:02 bb1129 volumio[3311]: info: ControllerMpd::pushState Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreCommandRouter::servicePushState Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreStateMachine::pushState Aug 28 14:52:02 bb1129 volumio[3311]: info: CorePlayQueue::getTrack 0 Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreCommandRouter::volumioPushState Aug 28 14:52:02 bb1129 volumio[3311]: info: CorePlayQueue::getTrack 0 Aug 28 14:52:02 bb1129 volumio[3311]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 28 14:52:02 bb1129 volumio[3311]: verbose: CURRENT POSITION 0 Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreStateMachine::syncState stateService stop Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreStateMachine::syncState currentStatus stop Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreStateMachine::pushState Aug 28 14:52:02 bb1129 volumio[3311]: info: CorePlayQueue::getTrack 0 Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreCommandRouter::volumioPushState Aug 28 14:52:02 bb1129 volumio[3311]: info: No code Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreStateMachine::pushState Aug 28 14:52:02 bb1129 volumio[3311]: info: CorePlayQueue::getTrack 0 Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreCommandRouter::volumioPushState Aug 28 14:52:02 bb1129 volumio[3311]: info: ------------------------------ 554ms Aug 28 14:52:02 bb1129 volumio[3311]: verbose: ControllerMpd::sendMpdCommand status Aug 28 14:52:02 bb1129 volumio[3311]: info: Aug 28 14:52:02 bb1129 volumio[3311]: ---------------------------- MPD announces state update: update Aug 28 14:52:02 bb1129 volumio[3311]: info: ControllerMpd::getState Aug 28 14:52:02 bb1129 volumio[3311]: verbose: ControllerMpd::sendMpdCommand status Aug 28 14:52:02 bb1129 volumio[3311]: verbose: ControllerMpd::sendMpdCommand status Aug 28 14:52:02 bb1129 volumio[3311]: info: Aug 28 14:52:02 bb1129 volumio[3311]: ---------------------------- MPD announces state update: update Aug 28 14:52:02 bb1129 volumio[3311]: info: ControllerMpd::getState Aug 28 14:52:02 bb1129 volumio[3311]: verbose: ControllerMpd::sendMpdCommand status Aug 28 14:52:02 bb1129 volumio[3311]: info: sendMpdCommand status took 162 milliseconds Aug 28 14:52:02 bb1129 volumio[3311]: info: sendMpdCommand status took 158 milliseconds Aug 28 14:52:02 bb1129 volumio[3311]: info: sendMpdCommand status took 19 milliseconds Aug 28 14:52:02 bb1129 volumio[3311]: info: sendMpdCommand status took 17 milliseconds Aug 28 14:52:02 bb1129 volumio[3311]: info: sendMpdCommand status took 16 milliseconds Aug 28 14:52:02 bb1129 volumio[3311]: info: sendMpdCommand status took 14 milliseconds Aug 28 14:52:02 bb1129 volumio[3311]: verbose: ControllerMpd::parseState Aug 28 14:52:02 bb1129 volumio[3311]: info: Command Router : Notfying DB Updatefalse Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreCommandRouter::Close All Modals sent Aug 28 14:52:02 bb1129 volumio[3311]: verbose: ControllerMpd::parseState Aug 28 14:52:02 bb1129 volumio[3311]: info: Command Router : Notfying DB Updatefalse Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreCommandRouter::Close All Modals sent Aug 28 14:52:02 bb1129 volumio[3311]: verbose: ControllerMpd::parseState Aug 28 14:52:02 bb1129 volumio[3311]: verbose: ControllerMpd::parseState Aug 28 14:52:02 bb1129 volumio[3311]: info: Command Router : Notfying DB Updatefalse Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreCommandRouter::Close All Modals sent Aug 28 14:52:02 bb1129 volumio[3311]: verbose: ControllerMpd::parseState Aug 28 14:52:02 bb1129 volumio[3311]: info: ControllerMpd::pushState Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreCommandRouter::servicePushState Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreStateMachine::pushState Aug 28 14:52:02 bb1129 volumio[3311]: info: CorePlayQueue::getTrack 0 Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreCommandRouter::volumioPushState Aug 28 14:52:02 bb1129 volumio[3311]: info: CorePlayQueue::getTrack 0 Aug 28 14:52:02 bb1129 volumio[3311]: 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} Aug 28 14:52:02 bb1129 volumio[3311]: verbose: CURRENT POSITION 0 Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreStateMachine::syncState stateService stop Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreStateMachine::syncState currentStatus stop Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreStateMachine::pushState Aug 28 14:52:02 bb1129 volumio[3311]: info: CorePlayQueue::getTrack 0 Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreCommandRouter::volumioPushState Aug 28 14:52:02 bb1129 volumio[3311]: info: No code Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreStateMachine::pushState Aug 28 14:52:02 bb1129 volumio[3311]: info: CorePlayQueue::getTrack 0 Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreCommandRouter::volumioPushState Aug 28 14:52:02 bb1129 volumio[3311]: info: ControllerMpd::pushState Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreCommandRouter::servicePushState Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreStateMachine::pushState Aug 28 14:52:02 bb1129 volumio[3311]: info: CorePlayQueue::getTrack 0 Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreCommandRouter::volumioPushState Aug 28 14:52:02 bb1129 volumio[3311]: info: CorePlayQueue::getTrack 0 Aug 28 14:52:02 bb1129 volumio[3311]: 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} Aug 28 14:52:02 bb1129 volumio[3311]: verbose: CURRENT POSITION 0 Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreStateMachine::syncState stateService stop Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreStateMachine::syncState currentStatus stop Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreStateMachine::pushState Aug 28 14:52:02 bb1129 volumio[3311]: info: CorePlayQueue::getTrack 0 Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreCommandRouter::volumioPushState Aug 28 14:52:02 bb1129 volumio[3311]: info: No code Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreStateMachine::pushState Aug 28 14:52:02 bb1129 volumio[3311]: info: CorePlayQueue::getTrack 0 Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreCommandRouter::volumioPushState Aug 28 14:52:02 bb1129 volumio[3311]: info: ControllerMpd::pushState Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreCommandRouter::servicePushState Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreStateMachine::pushState Aug 28 14:52:02 bb1129 volumio[3311]: info: CorePlayQueue::getTrack 0 Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreCommandRouter::volumioPushState Aug 28 14:52:02 bb1129 volumio[3311]: info: CorePlayQueue::getTrack 0 Aug 28 14:52:02 bb1129 volumio[3311]: 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} Aug 28 14:52:02 bb1129 volumio[3311]: verbose: CURRENT POSITION 0 Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreStateMachine::syncState stateService stop Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreStateMachine::syncState currentStatus stop Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreStateMachine::pushState Aug 28 14:52:02 bb1129 volumio[3311]: info: CorePlayQueue::getTrack 0 Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreCommandRouter::volumioPushState Aug 28 14:52:02 bb1129 volumio[3311]: info: No code Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreStateMachine::pushState Aug 28 14:52:02 bb1129 volumio[3311]: info: CorePlayQueue::getTrack 0 Aug 28 14:52:02 bb1129 volumio[3311]: info: CoreCommandRouter::volumioPushState Aug 28 14:52:02 bb1129 volumio[3311]: info: ------------------------------ 393ms Aug 28 14:52:02 bb1129 volumio[3311]: info: ------------------------------ 251ms Aug 28 14:52:02 bb1129 volumio[3311]: info: ------------------------------ 249ms Aug 28 14:52:03 bb1129 volumio[3311]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Aug 28 14:52:03 bb1129 volumio[3311]: verbose: ControllerMpd::sendMpdCommand rescan Aug 28 14:52:03 bb1129 volumio[3311]: verbose: ControllerMpd::sendMpdCommand status Aug 28 14:52:03 bb1129 volumio[3311]: info: Aug 28 14:52:03 bb1129 volumio[3311]: ---------------------------- MPD announces state update: update Aug 28 14:52:03 bb1129 volumio[3311]: info: sendMpdCommand rescan took 3 milliseconds Aug 28 14:52:03 bb1129 volumio[3311]: info: ControllerMpd::getState Aug 28 14:52:03 bb1129 volumio[3311]: verbose: ControllerMpd::sendMpdCommand status Aug 28 14:52:03 bb1129 volumio[3311]: verbose: ControllerMpd::sendMpdCommand status Aug 28 14:52:03 bb1129 volumio[3311]: info: Aug 28 14:52:03 bb1129 volumio[3311]: ---------------------------- MPD announces state update: update Aug 28 14:52:03 bb1129 volumio[3311]: info: ControllerMpd::getState Aug 28 14:52:03 bb1129 volumio[3311]: verbose: ControllerMpd::sendMpdCommand status Aug 28 14:52:03 bb1129 volumio[3311]: verbose: ControllerMpd::sendMpdCommand status Aug 28 14:52:03 bb1129 volumio[3311]: info: Aug 28 14:52:03 bb1129 volumio[3311]: ---------------------------- MPD announces state update: update Aug 28 14:52:03 bb1129 volumio[3311]: info: ControllerMpd::getState Aug 28 14:52:03 bb1129 volumio[3311]: verbose: ControllerMpd::sendMpdCommand status Aug 28 14:52:03 bb1129 volumio[3311]: verbose: ControllerMpd::sendMpdCommand status Aug 28 14:52:03 bb1129 volumio[3311]: info: Aug 28 14:52:03 bb1129 volumio[3311]: ---------------------------- MPD announces state update: update Aug 28 14:52:03 bb1129 volumio[3311]: info: sendMpdCommand status took 5 milliseconds Aug 28 14:52:03 bb1129 volumio[3311]: info: sendMpdCommand status took 4 milliseconds Aug 28 14:52:03 bb1129 volumio[3311]: info: ControllerMpd::getState Aug 28 14:52:03 bb1129 volumio[3311]: verbose: ControllerMpd::sendMpdCommand status Aug 28 14:52:03 bb1129 volumio[3311]: info: sendMpdCommand status took 4 milliseconds Aug 28 14:52:03 bb1129 volumio[3311]: info: sendMpdCommand status took 4 milliseconds Aug 28 14:52:03 bb1129 volumio[3311]: info: sendMpdCommand status took 3 milliseconds Aug 28 14:52:03 bb1129 volumio[3311]: info: sendMpdCommand status took 2 milliseconds Aug 28 14:52:03 bb1129 volumio[3311]: verbose: ControllerMpd::parseState Aug 28 14:52:03 bb1129 volumio[3311]: info: Command Router : Notfying DB Updatetrue Aug 28 14:52:03 bb1129 volumio[3311]: info: CoreCommandRouter::Close All Modals sent Aug 28 14:52:03 bb1129 volumio[3311]: verbose: ControllerMpd::parseState Aug 28 14:52:03 bb1129 volumio[3311]: verbose: ControllerMpd::parseState Aug 28 14:52:03 bb1129 volumio[3311]: info: Command Router : Notfying DB Updatefalse Aug 28 14:52:03 bb1129 volumio[3311]: info: CoreCommandRouter::Close All Modals sent Aug 28 14:52:03 bb1129 volumio[3311]: verbose: ControllerMpd::parseState Aug 28 14:52:03 bb1129 volumio[3311]: verbose: ControllerMpd::parseState Aug 28 14:52:03 bb1129 volumio[3311]: info: Command Router : Notfying DB Updatefalse Aug 28 14:52:03 bb1129 volumio[3311]: info: CoreCommandRouter::Close All Modals sent Aug 28 14:52:03 bb1129 volumio[3311]: verbose: ControllerMpd::parseState Aug 28 14:52:03 bb1129 volumio[3311]: info: ControllerMpd::pushState Aug 28 14:52:03 bb1129 volumio[3311]: info: CoreCommandRouter::servicePushState Aug 28 14:52:03 bb1129 volumio[3311]: info: CoreStateMachine::pushState Aug 28 14:52:03 bb1129 volumio[3311]: info: CorePlayQueue::getTrack 0 Aug 28 14:52:03 bb1129 volumio[3311]: info: CoreCommandRouter::volumioPushState Aug 28 14:52:03 bb1129 volumio[3311]: info: CorePlayQueue::getTrack 0 Aug 28 14:52:03 bb1129 volumio[3311]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 28 14:52:03 bb1129 volumio[3311]: verbose: CURRENT POSITION 0 Aug 28 14:52:03 bb1129 volumio[3311]: info: CoreStateMachine::syncState stateService stop Aug 28 14:52:03 bb1129 volumio[3311]: info: CoreStateMachine::syncState currentStatus stop Aug 28 14:52:03 bb1129 volumio[3311]: info: CoreStateMachine::pushState Aug 28 14:52:03 bb1129 volumio[3311]: info: CorePlayQueue::getTrack 0 Aug 28 14:52:03 bb1129 volumio[3311]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 28 14:52:03 bb1129 volumio[3311]: info: CoreCommandRouter::volumioPushState Aug 28 14:52:03 bb1129 volumio[3311]: info: No code Aug 28 14:52:03 bb1129 volumio[3311]: info: CoreStateMachine::pushState Aug 28 14:52:03 bb1129 volumio[3311]: info: CorePlayQueue::getTrack 0 Aug 28 14:52:03 bb1129 volumio[3311]: info: CoreCommandRouter::volumioPushState Aug 28 14:52:03 bb1129 volumio[3311]: info: ControllerMpd::pushState Aug 28 14:52:03 bb1129 volumio[3311]: info: CoreCommandRouter::servicePushState Aug 28 14:52:03 bb1129 volumio[3311]: info: CoreStateMachine::pushState Aug 28 14:52:03 bb1129 volumio[3311]: info: CorePlayQueue::getTrack 0 Aug 28 14:52:03 bb1129 volumio[3311]: info: CoreCommandRouter::volumioPushState Aug 28 14:52:03 bb1129 volumio[3311]: info: CorePlayQueue::getTrack 0 Aug 28 14:52:03 bb1129 volumio[3311]: 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} Aug 28 14:52:03 bb1129 volumio[3311]: verbose: CURRENT POSITION 0 Aug 28 14:52:03 bb1129 volumio[3311]: info: CoreStateMachine::syncState stateService stop Aug 28 14:52:03 bb1129 volumio[3311]: info: CoreStateMachine::syncState currentStatus stop Aug 28 14:52:03 bb1129 volumio[3311]: info: CoreStateMachine::pushState Aug 28 14:52:03 bb1129 volumio[3311]: info: CorePlayQueue::getTrack 0 Aug 28 14:52:03 bb1129 volumio[3311]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 28 14:52:03 bb1129 volumio[3311]: info: CoreCommandRouter::volumioPushState Aug 28 14:52:03 bb1129 volumio[3311]: info: No code Aug 28 14:52:03 bb1129 volumio[3311]: info: CoreStateMachine::pushState Aug 28 14:52:03 bb1129 volumio[3311]: info: CorePlayQueue::getTrack 0 Aug 28 14:52:03 bb1129 volumio[3311]: info: CoreCommandRouter::volumioPushState Aug 28 14:52:03 bb1129 volumio[3311]: info: ControllerMpd::pushState Aug 28 14:52:03 bb1129 volumio[3311]: info: CoreCommandRouter::servicePushState Aug 28 14:52:03 bb1129 volumio[3311]: info: CoreStateMachine::pushState Aug 28 14:52:03 bb1129 volumio[3311]: info: CorePlayQueue::getTrack 0 Aug 28 14:52:03 bb1129 volumio[3311]: info: CoreCommandRouter::volumioPushState Aug 28 14:52:03 bb1129 volumio[3311]: info: CorePlayQueue::getTrack 0 Aug 28 14:52:03 bb1129 volumio[3311]: 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} Aug 28 14:52:03 bb1129 volumio[3311]: verbose: CURRENT POSITION 0 Aug 28 14:52:03 bb1129 volumio[3311]: info: CoreStateMachine::syncState stateService stop Aug 28 14:52:03 bb1129 volumio[3311]: info: CoreStateMachine::syncState currentStatus stop Aug 28 14:52:03 bb1129 volumio[3311]: info: CoreStateMachine::pushState Aug 28 14:52:03 bb1129 volumio[3311]: info: CorePlayQueue::getTrack 0 Aug 28 14:52:03 bb1129 volumio[3311]: info: CoreCommandRouter::volumioPushState Aug 28 14:52:03 bb1129 volumio[3311]: info: No code Aug 28 14:52:03 bb1129 volumio[3311]: info: CoreStateMachine::pushState Aug 28 14:52:03 bb1129 volumio[3311]: info: CorePlayQueue::getTrack 0 Aug 28 14:52:03 bb1129 volumio[3311]: info: CoreCommandRouter::volumioPushState Aug 28 14:52:03 bb1129 volumio[3311]: info: ------------------------------ 259ms Aug 28 14:52:03 bb1129 volumio[3311]: info: ------------------------------ 258ms Aug 28 14:52:03 bb1129 volumio[3311]: info: ------------------------------ 258ms Aug 28 14:52:03 bb1129 volumio[3311]: verbose: ControllerMpd::sendMpdCommand status Aug 28 14:52:03 bb1129 volumio[3311]: info: Aug 28 14:52:03 bb1129 volumio[3311]: ---------------------------- MPD announces state update: update Aug 28 14:52:03 bb1129 volumio[3311]: info: ControllerMpd::getState Aug 28 14:52:03 bb1129 volumio[3311]: verbose: ControllerMpd::sendMpdCommand status Aug 28 14:52:03 bb1129 volumio[3311]: info: Aug 28 14:52:03 bb1129 volumio[3311]: ---------------------------- MPD announces state update: update Aug 28 14:52:03 bb1129 volumio[3311]: info: ControllerMpd::getState Aug 28 14:52:03 bb1129 volumio[3311]: verbose: ControllerMpd::sendMpdCommand status Aug 28 14:52:03 bb1129 volumio[3311]: info: sendMpdCommand status took 263 milliseconds Aug 28 14:52:03 bb1129 volumio[3311]: info: sendMpdCommand status took 261 milliseconds Aug 28 14:52:03 bb1129 volumio[3311]: info: sendMpdCommand status took 5 milliseconds Aug 28 14:52:03 bb1129 volumio[3311]: info: sendMpdCommand status took 5 milliseconds Aug 28 14:52:03 bb1129 volumio[3311]: info: sendMpdCommand status took 5 milliseconds Aug 28 14:52:03 bb1129 volumio[3311]: info: sendMpdCommand status took 3 milliseconds Aug 28 14:52:03 bb1129 volumio[3311]: verbose: ControllerMpd::parseState Aug 28 14:52:03 bb1129 volumio[3311]: info: Command Router : Notfying DB Updatefalse Aug 28 14:52:03 bb1129 volumio[3311]: info: CoreCommandRouter::Close All Modals sent Aug 28 14:52:03 bb1129 volumio[3311]: verbose: ControllerMpd::parseState Aug 28 14:52:03 bb1129 volumio[3311]: verbose: ControllerMpd::parseState Aug 28 14:52:03 bb1129 volumio[3311]: info: Command Router : Notfying DB Updatefalse Aug 28 14:52:03 bb1129 volumio[3311]: info: CoreCommandRouter::Close All Modals sent Aug 28 14:52:03 bb1129 volumio[3311]: verbose: ControllerMpd::parseState Aug 28 14:52:03 bb1129 volumio[3311]: verbose: ControllerMpd::parseState Aug 28 14:52:04 bb1129 volumio[3311]: info: Command Router : Notfying DB Updatefalse Aug 28 14:52:04 bb1129 volumio[3311]: info: CoreCommandRouter::Close All Modals sent Aug 28 14:52:04 bb1129 volumio[3311]: verbose: ControllerMpd::parseState Aug 28 14:52:04 bb1129 volumio[3311]: info: ControllerMpd::pushState Aug 28 14:52:04 bb1129 volumio[3311]: info: CoreCommandRouter::servicePushState Aug 28 14:52:04 bb1129 volumio[3311]: info: CoreStateMachine::pushState Aug 28 14:52:04 bb1129 volumio[3311]: info: CorePlayQueue::getTrack 0 Aug 28 14:52:04 bb1129 volumio[3311]: info: CoreCommandRouter::volumioPushState Aug 28 14:52:04 bb1129 volumio[3311]: info: CorePlayQueue::getTrack 0 Aug 28 14:52:04 bb1129 volumio[3311]: 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} Aug 28 14:52:04 bb1129 volumio[3311]: verbose: CURRENT POSITION 0 Aug 28 14:52:04 bb1129 volumio[3311]: info: CoreStateMachine::syncState stateService stop Aug 28 14:52:04 bb1129 volumio[3311]: info: CoreStateMachine::syncState currentStatus stop Aug 28 14:52:04 bb1129 volumio[3311]: info: CoreStateMachine::pushState Aug 28 14:52:04 bb1129 volumio[3311]: info: CorePlayQueue::getTrack 0 Aug 28 14:52:04 bb1129 volumio[3311]: info: CoreCommandRouter::volumioPushState Aug 28 14:52:04 bb1129 volumio[3311]: info: No code Aug 28 14:52:04 bb1129 volumio[3311]: info: CoreStateMachine::pushState Aug 28 14:52:04 bb1129 volumio[3311]: info: CorePlayQueue::getTrack 0 Aug 28 14:52:04 bb1129 volumio[3311]: info: CoreCommandRouter::volumioPushState Aug 28 14:52:04 bb1129 volumio[3311]: info: ControllerMpd::pushState Aug 28 14:52:04 bb1129 volumio[3311]: info: CoreCommandRouter::servicePushState Aug 28 14:52:04 bb1129 volumio[3311]: info: CoreStateMachine::pushState Aug 28 14:52:04 bb1129 volumio[3311]: info: CorePlayQueue::getTrack 0 Aug 28 14:52:04 bb1129 volumio[3311]: info: CoreCommandRouter::volumioPushState Aug 28 14:52:04 bb1129 volumio[3311]: info: CorePlayQueue::getTrack 0 Aug 28 14:52:04 bb1129 volumio[3311]: 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} Aug 28 14:52:04 bb1129 volumio[3311]: verbose: CURRENT POSITION 0 Aug 28 14:52:04 bb1129 volumio[3311]: info: CoreStateMachine::syncState stateService stop Aug 28 14:52:04 bb1129 volumio[3311]: info: CoreStateMachine::syncState currentStatus stop Aug 28 14:52:04 bb1129 volumio[3311]: info: CoreStateMachine::pushState Aug 28 14:52:04 bb1129 volumio[3311]: info: CorePlayQueue::getTrack 0 Aug 28 14:52:04 bb1129 volumio[3311]: info: CoreCommandRouter::volumioPushState Aug 28 14:52:04 bb1129 volumio[3311]: info: No code Aug 28 14:52:04 bb1129 volumio[3311]: info: CoreStateMachine::pushState Aug 28 14:52:04 bb1129 volumio[3311]: info: CorePlayQueue::getTrack 0 Aug 28 14:52:04 bb1129 volumio[3311]: info: CoreCommandRouter::volumioPushState Aug 28 14:52:04 bb1129 volumio[3311]: info: ControllerMpd::pushState Aug 28 14:52:04 bb1129 volumio[3311]: info: CoreCommandRouter::servicePushState Aug 28 14:52:04 bb1129 volumio[3311]: info: CoreStateMachine::pushState Aug 28 14:52:04 bb1129 volumio[3311]: info: CorePlayQueue::getTrack 0 Aug 28 14:52:04 bb1129 volumio[3311]: info: CoreCommandRouter::volumioPushState Aug 28 14:52:04 bb1129 volumio[3311]: info: CorePlayQueue::getTrack 0 Aug 28 14:52:04 bb1129 volumio[3311]: 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} Aug 28 14:52:04 bb1129 volumio[3311]: verbose: CURRENT POSITION 0 Aug 28 14:52:04 bb1129 volumio[3311]: info: CoreStateMachine::syncState stateService stop Aug 28 14:52:04 bb1129 volumio[3311]: info: CoreStateMachine::syncState currentStatus stop Aug 28 14:52:04 bb1129 volumio[3311]: info: CoreStateMachine::pushState Aug 28 14:52:04 bb1129 volumio[3311]: info: CorePlayQueue::getTrack 0 Aug 28 14:52:04 bb1129 volumio[3311]: info: CoreCommandRouter::volumioPushState Aug 28 14:52:04 bb1129 volumio[3311]: info: No code Aug 28 14:52:04 bb1129 volumio[3311]: info: CoreStateMachine::pushState Aug 28 14:52:04 bb1129 volumio[3311]: info: CorePlayQueue::getTrack 0 Aug 28 14:52:04 bb1129 volumio[3311]: info: CoreCommandRouter::volumioPushState Aug 28 14:52:04 bb1129 volumio[3311]: info: ------------------------------ 411ms Aug 28 14:52:04 bb1129 volumio[3311]: info: ------------------------------ 154ms Aug 28 14:52:04 bb1129 volumio[3311]: info: ------------------------------ 153ms Aug 28 14:52:05 bb1129 volumio[3311]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 28 14:52:06 bb1129 volumio[3311]: info: CoreCommandRouter::volumioGetState Aug 28 14:52:06 bb1129 volumio[3311]: info: CorePlayQueue::getTrack 0 Aug 28 14:52:06 bb1129 volumio[3311]: info: Listing playlists Aug 28 14:52:06 bb1129 volumio[3311]: info: Listing playlists Aug 28 14:52:07 bb1129 volumio[3311]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Aug 28 14:52:07 bb1129 volumio[3311]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Aug 28 14:52:09 bb1129 volumio[3311]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 28 14:52:12 bb1129 volumio[3311]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 28 14:52:12 bb1129 volumio[3311]: Error: dns service error: unknown Aug 28 14:52:12 bb1129 volumio[3311]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30) Aug 28 14:52:12 bb1129 volumio[3311]: at SocketWatcher.MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Aug 28 14:52:12 bb1129 volumio[3311]: errorCode: -65537 Aug 28 14:52:12 bb1129 volumio[3311]: } Aug 28 14:52:12 bb1129 volumio[3311]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 28 14:52:12 bb1129 sudo[4276]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-28 14:51 Aug 28 14:52:12 bb1129 sudo[4276]: 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="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:48:50 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="1049be5fd382035818795b7f5c38e10d"