-- Logs begin at Sat 2024-05-11 10:28:21 CST, end at Sat 2024-05-11 21:20:39 CST. -- May 11 21:19:00 volumio kernel: CIFS: VFS: \\192.168.5.1\USB_Storage BAD_NETWORK_NAME: \\192.168.5.1\USB_Storage May 11 21:19:00 volumio kernel: CIFS: VFS: reconnect tcon failed rc = -2 May 11 21:19:00 volumio volumio[6454]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb May 11 21:19:00 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand update May 11 21:19:00 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand status May 11 21:19:00 volumio volumio[6454]: info: May 11 21:19:00 volumio volumio[6454]: ---------------------------- MPD announces state update: update May 11 21:19:00 volumio volumio[6454]: info: sendMpdCommand update took 2 milliseconds May 11 21:19:00 volumio volumio[6454]: info: ControllerMpd::getState May 11 21:19:00 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand status May 11 21:19:00 volumio volumio[6454]: info: sendMpdCommand status took 1 milliseconds May 11 21:19:00 volumio volumio[6454]: info: sendMpdCommand status took 1 milliseconds May 11 21:19:00 volumio volumio[6454]: verbose: ControllerMpd::parseState May 11 21:19:00 volumio kernel: CIFS: VFS: \\192.168.5.1\USB_Storage BAD_NETWORK_NAME: \\192.168.5.1\USB_Storage May 11 21:19:00 volumio kernel: CIFS: VFS: reconnect tcon failed rc = -2 May 11 21:19:00 volumio volumio[6454]: info: Command Router : Notfying DB Updatetrue May 11 21:19:00 volumio volumio[6454]: verbose: ControllerMpd::parseState May 11 21:19:00 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 11 21:19:00 volumio kernel: CIFS: VFS: \\192.168.5.1\USB_Storage BAD_NETWORK_NAME: \\192.168.5.1\USB_Storage May 11 21:19:00 volumio kernel: CIFS: VFS: reconnect tcon failed rc = -2 May 11 21:19:00 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand status May 11 21:19:00 volumio volumio[6454]: info: May 11 21:19:00 volumio volumio[6454]: ---------------------------- MPD announces state update: update May 11 21:19:00 volumio volumio[6454]: info: ControllerMpd::getState May 11 21:19:00 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand status May 11 21:19:00 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand status May 11 21:19:00 volumio volumio[6454]: info: May 11 21:19:00 volumio volumio[6454]: ---------------------------- MPD announces state update: update May 11 21:19:00 volumio volumio[6454]: info: ControllerMpd::getState May 11 21:19:00 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand status May 11 21:19:00 volumio volumio[6454]: info: May 11 21:19:00 volumio volumio[6454]: ---------------------------- MPD announces system playlist update May 11 21:19:00 volumio volumio[6454]: info: Ignoring MPD Status Update May 11 21:19:00 volumio volumio[6454]: info: MPD Database updated - AlbumList cache refreshed May 11 21:19:00 volumio volumio[6454]: info: May 11 21:19:00 volumio volumio[6454]: ---------------------------- MPD announces state update: database May 11 21:19:00 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand status May 11 21:19:00 volumio volumio[6454]: info: May 11 21:19:00 volumio volumio[6454]: ---------------------------- MPD announces state update: update May 11 21:19:00 volumio volumio[6454]: info: sendMpdCommand playlistinfo took 5 milliseconds May 11 21:19:00 volumio volumio[6454]: info: ControllerMpd::getState May 11 21:19:00 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand status May 11 21:19:00 volumio volumio[6454]: info: ControllerMpd::getState May 11 21:19:00 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand status May 11 21:19:00 volumio volumio[6454]: info: sendMpdCommand status took 2 milliseconds May 11 21:19:00 volumio volumio[6454]: info: sendMpdCommand status took 3 milliseconds May 11 21:19:00 volumio volumio[6454]: info: sendMpdCommand status took 3 milliseconds May 11 21:19:00 volumio volumio[6454]: info: sendMpdCommand status took 2 milliseconds May 11 21:19:00 volumio volumio[6454]: verbose: ControllerMpd::parseTrackInfo May 11 21:19:00 volumio volumio[6454]: verbose: ControllerMpd::parseState May 11 21:19:00 volumio volumio[6454]: info: Command Router : Notfying DB Updatefalse May 11 21:19:00 volumio volumio[6454]: info: CoreCommandRouter::Close All Modals sent May 11 21:19:00 volumio volumio[6454]: verbose: ControllerMpd::parseState May 11 21:19:00 volumio volumio[6454]: verbose: ControllerMpd::parseState May 11 21:19:00 volumio volumio[6454]: info: Command Router : Notfying DB Updatefalse May 11 21:19:00 volumio volumio[6454]: info: CoreCommandRouter::Close All Modals sent May 11 21:19:00 volumio volumio[6454]: verbose: ControllerMpd::parseState May 11 21:19:00 volumio volumio[6454]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 11 21:19:00 volumio volumio[6454]: info: ControllerMpd::pushState May 11 21:19:00 volumio volumio[6454]: info: CoreCommandRouter::servicePushState May 11 21:19:00 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:19:00 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:19:00 volumio volumio[6454]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 11 21:19:00 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:19:00 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:19:00 volumio volumio[6454]: 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 11 21:19:00 volumio volumio[6454]: verbose: CURRENT POSITION 0 May 11 21:19:00 volumio volumio[6454]: info: CoreStateMachine::syncState stateService stop May 11 21:19:00 volumio volumio[6454]: info: CoreStateMachine::syncState currentStatus stop May 11 21:19:00 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:19:00 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:19:00 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:19:00 volumio volumio[6454]: info: No code May 11 21:19:00 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:19:00 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:19:00 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:19:00 volumio volumio[6454]: info: ControllerMpd::pushState May 11 21:19:00 volumio volumio[6454]: info: CoreCommandRouter::servicePushState May 11 21:19:00 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:19:00 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:19:00 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:19:00 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:19:00 volumio volumio[6454]: 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 11 21:19:00 volumio volumio[6454]: verbose: CURRENT POSITION 0 May 11 21:19:00 volumio volumio[6454]: info: CoreStateMachine::syncState stateService stop May 11 21:19:00 volumio volumio[6454]: info: CoreStateMachine::syncState currentStatus stop May 11 21:19:00 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:19:00 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:19:00 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:19:00 volumio volumio[6454]: info: No code May 11 21:19:00 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:19:00 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:19:00 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:19:00 volumio volumio[6454]: info: ------------------------------ 45ms May 11 21:19:00 volumio volumio[6454]: info: ------------------------------ 43ms May 11 21:19:00 volumio volumio[6454]: info: ------------------------------ 44ms May 11 21:19:00 volumio volumio[6454]: info: MPD Database updated - AlbumList cache refreshed May 11 21:19:00 volumio volumio[6454]: info: May 11 21:19:00 volumio volumio[6454]: ---------------------------- MPD announces state update: database May 11 21:19:00 volumio volumio[6454]: info: May 11 21:19:00 volumio volumio[6454]: ---------------------------- MPD announces system playlist update May 11 21:19:00 volumio volumio[6454]: info: Ignoring MPD Status Update May 11 21:19:00 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand status May 11 21:19:00 volumio volumio[6454]: info: May 11 21:19:00 volumio volumio[6454]: ---------------------------- MPD announces state update: update May 11 21:19:00 volumio volumio[6454]: info: ControllerMpd::getState May 11 21:19:00 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand status May 11 21:19:00 volumio volumio[6454]: info: ControllerMpd::getState May 11 21:19:00 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand status May 11 21:19:00 volumio volumio[6454]: info: MPD Database updated - AlbumList cache refreshed May 11 21:19:00 volumio volumio[6454]: info: May 11 21:19:00 volumio volumio[6454]: ---------------------------- MPD announces state update: database May 11 21:19:00 volumio volumio[6454]: info: May 11 21:19:00 volumio volumio[6454]: ---------------------------- MPD announces system playlist update May 11 21:19:00 volumio volumio[6454]: info: Ignoring MPD Status Update May 11 21:19:00 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand status May 11 21:19:00 volumio volumio[6454]: info: May 11 21:19:00 volumio volumio[6454]: ---------------------------- MPD announces state update: update May 11 21:19:00 volumio volumio[6454]: info: ControllerMpd::getState May 11 21:19:00 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand status May 11 21:19:00 volumio volumio[6454]: info: ControllerMpd::getState May 11 21:19:00 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand status May 11 21:19:00 volumio volumio[6454]: error: updateQueue error: null May 11 21:19:00 volumio volumio[6454]: error: updateQueue error: null May 11 21:19:00 volumio volumio[6454]: info: sendMpdCommand status took 53 milliseconds May 11 21:19:00 volumio volumio[6454]: info: ------------------------------ 54ms May 11 21:19:00 volumio volumio[6454]: info: sendMpdCommand status took 53 milliseconds May 11 21:19:00 volumio volumio[6454]: info: sendMpdCommand status took 10 milliseconds May 11 21:19:00 volumio volumio[6454]: info: ------------------------------ 10ms May 11 21:19:00 volumio volumio[6454]: info: sendMpdCommand status took 9 milliseconds May 11 21:19:00 volumio volumio[6454]: info: sendMpdCommand status took 8 milliseconds May 11 21:19:00 volumio volumio[6454]: info: sendMpdCommand status took 9 milliseconds May 11 21:19:00 volumio volumio[6454]: info: ------------------------------ 9ms May 11 21:19:00 volumio volumio[6454]: info: sendMpdCommand status took 8 milliseconds May 11 21:19:00 volumio volumio[6454]: verbose: ControllerMpd::parseState May 11 21:19:00 volumio volumio[6454]: info: Command Router : Notfying DB Updatefalse May 11 21:19:00 volumio volumio[6454]: info: CoreCommandRouter::Close All Modals sent May 11 21:19:00 volumio volumio[6454]: verbose: ControllerMpd::parseState May 11 21:19:00 volumio volumio[6454]: verbose: ControllerMpd::parseState May 11 21:19:00 volumio volumio[6454]: verbose: ControllerMpd::parseState May 11 21:19:00 volumio volumio[6454]: info: Command Router : Notfying DB Updatefalse May 11 21:19:00 volumio volumio[6454]: info: CoreCommandRouter::Close All Modals sent May 11 21:19:00 volumio volumio[6454]: verbose: ControllerMpd::parseState May 11 21:19:00 volumio volumio[6454]: verbose: ControllerMpd::parseState May 11 21:19:00 volumio volumio[6454]: verbose: ControllerMpd::parseState May 11 21:19:00 volumio volumio[6454]: info: Command Router : Notfying DB Updatefalse May 11 21:19:00 volumio volumio[6454]: info: CoreCommandRouter::Close All Modals sent May 11 21:19:00 volumio volumio[6454]: verbose: ControllerMpd::parseState May 11 21:19:00 volumio volumio[6454]: verbose: ControllerMpd::parseState May 11 21:19:00 volumio volumio[6454]: info: ControllerMpd::pushState May 11 21:19:00 volumio volumio[6454]: info: CoreCommandRouter::servicePushState May 11 21:19:00 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:19:00 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:19:00 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:19:00 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:19:00 volumio volumio[6454]: 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 11 21:19:00 volumio volumio[6454]: verbose: CURRENT POSITION 0 May 11 21:19:00 volumio volumio[6454]: info: CoreStateMachine::syncState stateService stop May 11 21:19:00 volumio volumio[6454]: info: CoreStateMachine::syncState currentStatus stop May 11 21:19:00 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:19:00 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:19:00 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:19:00 volumio volumio[6454]: info: No code May 11 21:19:00 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:19:00 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:19:00 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:19:00 volumio volumio[6454]: info: ControllerMpd::pushState May 11 21:19:00 volumio volumio[6454]: info: CoreCommandRouter::servicePushState May 11 21:19:00 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:19:00 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:19:00 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:19:00 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:19:00 volumio volumio[6454]: 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 11 21:19:00 volumio volumio[6454]: verbose: CURRENT POSITION 0 May 11 21:19:00 volumio volumio[6454]: info: CoreStateMachine::syncState stateService stop May 11 21:19:00 volumio volumio[6454]: info: CoreStateMachine::syncState currentStatus stop May 11 21:19:00 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:19:00 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:19:00 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:19:00 volumio volumio[6454]: info: No code May 11 21:19:00 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:19:00 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:19:00 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:19:00 volumio volumio[6454]: info: ControllerMpd::pushState May 11 21:19:00 volumio volumio[6454]: info: CoreCommandRouter::servicePushState May 11 21:19:00 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:19:00 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:19:00 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:19:00 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:19:00 volumio volumio[6454]: 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 11 21:19:00 volumio volumio[6454]: verbose: CURRENT POSITION 0 May 11 21:19:00 volumio volumio[6454]: info: CoreStateMachine::syncState stateService stop May 11 21:19:00 volumio volumio[6454]: info: CoreStateMachine::syncState currentStatus stop May 11 21:19:00 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:19:00 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:19:00 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:19:00 volumio volumio[6454]: info: No code May 11 21:19:00 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:19:00 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:19:00 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:19:00 volumio volumio[6454]: info: ControllerMpd::pushState May 11 21:19:00 volumio volumio[6454]: info: CoreCommandRouter::servicePushState May 11 21:19:00 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:19:00 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:19:00 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:19:00 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:19:00 volumio volumio[6454]: 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 11 21:19:00 volumio volumio[6454]: verbose: CURRENT POSITION 0 May 11 21:19:00 volumio volumio[6454]: info: CoreStateMachine::syncState stateService stop May 11 21:19:00 volumio volumio[6454]: info: CoreStateMachine::syncState currentStatus stop May 11 21:19:00 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:19:00 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:19:00 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:19:00 volumio volumio[6454]: info: No code May 11 21:19:00 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:19:00 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:19:00 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:19:00 volumio volumio[6454]: info: ControllerMpd::pushState May 11 21:19:00 volumio volumio[6454]: info: CoreCommandRouter::servicePushState May 11 21:19:00 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:19:00 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:19:00 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:19:00 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:19:00 volumio volumio[6454]: 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 11 21:19:00 volumio volumio[6454]: verbose: CURRENT POSITION 0 May 11 21:19:00 volumio volumio[6454]: info: CoreStateMachine::syncState stateService stop May 11 21:19:00 volumio volumio[6454]: info: CoreStateMachine::syncState currentStatus stop May 11 21:19:00 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:19:00 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:19:00 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:19:00 volumio volumio[6454]: info: No code May 11 21:19:00 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:19:00 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:19:00 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:19:00 volumio volumio[6454]: info: ControllerMpd::pushState May 11 21:19:00 volumio volumio[6454]: info: CoreCommandRouter::servicePushState May 11 21:19:00 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:19:00 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:19:00 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:19:00 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:19:00 volumio volumio[6454]: 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 11 21:19:00 volumio volumio[6454]: verbose: CURRENT POSITION 0 May 11 21:19:00 volumio volumio[6454]: info: CoreStateMachine::syncState stateService stop May 11 21:19:00 volumio volumio[6454]: info: CoreStateMachine::syncState currentStatus stop May 11 21:19:00 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:19:00 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:19:00 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:19:00 volumio volumio[6454]: info: No code May 11 21:19:00 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:19:00 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:19:00 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:19:00 volumio volumio[6454]: info: ------------------------------ 122ms May 11 21:19:00 volumio volumio[6454]: info: ------------------------------ 123ms May 11 21:19:00 volumio volumio[6454]: info: ------------------------------ 81ms May 11 21:19:00 volumio volumio[6454]: info: ------------------------------ 80ms May 11 21:19:00 volumio volumio[6454]: info: ------------------------------ 79ms May 11 21:19:00 volumio volumio[6454]: info: ------------------------------ 79ms May 11 21:19:02 volumio kernel: CIFS: VFS: \\192.168.5.1\USB_Storage BAD_NETWORK_NAME: \\192.168.5.1\USB_Storage May 11 21:19:02 volumio kernel: CIFS: VFS: reconnect tcon failed rc = -2 May 11 21:19:03 volumio volumio[6454]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 11 21:19:04 volumio kernel: CIFS: VFS: \\192.168.5.1\USB_Storage BAD_NETWORK_NAME: \\192.168.5.1\USB_Storage May 11 21:19:04 volumio kernel: CIFS: VFS: reconnect tcon failed rc = -2 May 11 21:19:06 volumio kernel: CIFS: VFS: \\192.168.5.1\USB_Storage BAD_NETWORK_NAME: \\192.168.5.1\USB_Storage May 11 21:19:06 volumio kernel: CIFS: VFS: reconnect tcon failed rc = -2 May 11 21:19:08 volumio kernel: CIFS: VFS: \\192.168.5.1\USB_Storage BAD_NETWORK_NAME: \\192.168.5.1\USB_Storage May 11 21:19:08 volumio kernel: CIFS: VFS: reconnect tcon failed rc = -2 May 11 21:19:10 volumio volumio[6454]: info: CoreCommandRouter::getUIConfigOnPlugin May 11 21:19:10 volumio volumio[6454]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 11 21:19:10 volumio volumio[6454]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 11 21:19:10 volumio volumio[6454]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 11 21:19:10 volumio volumio[6454]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 11 21:19:10 volumio volumio[6454]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 11 21:19:10 volumio volumio[6454]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 11 21:19:10 volumio volumio[6454]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 11 21:19:10 volumio volumio[6454]: info: CoreCommandRouter::volumioGetBrowseSources May 11 21:19:10 volumio volumio[6454]: info: CoreCommandRouter::volumioGetBrowseSources May 11 21:19:10 volumio volumio[6454]: info: CoreCommandRouter::volumioGetBrowseSources May 11 21:19:10 volumio volumio[6454]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 11 21:19:10 volumio volumio[6454]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 11 21:19:10 volumio kernel: CIFS: VFS: \\192.168.5.1\USB_Storage BAD_NETWORK_NAME: \\192.168.5.1\USB_Storage May 11 21:19:10 volumio kernel: CIFS: VFS: reconnect tcon failed rc = -2 May 11 21:19:10 volumio kernel: CIFS: VFS: \\192.168.5.1\USB_Storage BAD_NETWORK_NAME: \\192.168.5.1\USB_Storage May 11 21:19:10 volumio kernel: CIFS: VFS: reconnect tcon failed rc = -2 May 11 21:19:12 volumio kernel: CIFS: VFS: \\192.168.5.1\USB_Storage BAD_NETWORK_NAME: \\192.168.5.1\USB_Storage May 11 21:19:12 volumio kernel: CIFS: VFS: reconnect tcon failed rc = -2 May 11 21:19:14 volumio volumio[6454]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 11 21:19:14 volumio kernel: CIFS: VFS: \\192.168.5.1\USB_Storage BAD_NETWORK_NAME: \\192.168.5.1\USB_Storage May 11 21:19:14 volumio kernel: CIFS: VFS: reconnect tcon failed rc = -2 May 11 21:19:16 volumio kernel: CIFS: VFS: \\192.168.5.1\USB_Storage BAD_NETWORK_NAME: \\192.168.5.1\USB_Storage May 11 21:19:16 volumio kernel: CIFS: VFS: reconnect tcon failed rc = -2 May 11 21:19:18 volumio volumio[6454]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 11 21:19:18 volumio kernel: CIFS: VFS: \\192.168.5.1\USB_Storage BAD_NETWORK_NAME: \\192.168.5.1\USB_Storage May 11 21:19:18 volumio kernel: CIFS: VFS: reconnect tcon failed rc = -2 May 11 21:19:20 volumio kernel: CIFS: VFS: \\192.168.5.1\USB_Storage BAD_NETWORK_NAME: \\192.168.5.1\USB_Storage May 11 21:19:20 volumio kernel: CIFS: VFS: reconnect tcon failed rc = -2 May 11 21:19:22 volumio volumio[6454]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 11 21:19:22 volumio kernel: CIFS: VFS: \\192.168.5.1\USB_Storage BAD_NETWORK_NAME: \\192.168.5.1\USB_Storage May 11 21:19:22 volumio kernel: CIFS: VFS: reconnect tcon failed rc = -2 May 11 21:19:24 volumio kernel: CIFS: VFS: \\192.168.5.1\USB_Storage BAD_NETWORK_NAME: \\192.168.5.1\USB_Storage May 11 21:19:24 volumio kernel: CIFS: VFS: reconnect tcon failed rc = -2 May 11 21:19:25 volumio volumio[6454]: info: CoreCommandRouter::executeOnPlugin: networkfs , editShare May 11 21:19:25 volumio sudo[6844]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount /mnt/NAS/router May 11 21:19:25 volumio sudo[6844]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 21:19:25 volumio systemd[1]: mnt-NAS-router.mount: Succeeded. May 11 21:19:25 volumio kernel: CIFS: VFS: \\192.168.5.1\USB_Storage BAD_NETWORK_NAME: \\192.168.5.1\USB_Storage May 11 21:19:25 volumio kernel: CIFS: VFS: reconnect tcon failed rc = -2 May 11 21:19:25 volumio sudo[6844]: pam_unix(sudo:session): session closed for user root May 11 21:19:25 volumio volumio[6454]: info: Share router successfully unmounted May 11 21:19:25 volumio sudo[6848]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.5.1/Netgear /mnt/NAS/router May 11 21:19:25 volumio sudo[6848]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 21:19:25 volumio kernel: CIFS: Attempting to mount //192.168.5.1/Netgear May 11 21:19:25 volumio sudo[6848]: pam_unix(sudo:session): session closed for user root May 11 21:19:25 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand status May 11 21:19:25 volumio volumio[6454]: info: May 11 21:19:25 volumio volumio[6454]: ---------------------------- MPD announces state update: update May 11 21:19:25 volumio volumio[6454]: info: ControllerMpd::getState May 11 21:19:25 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand status May 11 21:19:25 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand status May 11 21:19:25 volumio volumio[6454]: info: May 11 21:19:25 volumio volumio[6454]: ---------------------------- MPD announces state update: update May 11 21:19:25 volumio volumio[6454]: info: ControllerMpd::getState May 11 21:19:25 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand status May 11 21:19:25 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand status May 11 21:19:25 volumio volumio[6454]: info: May 11 21:19:25 volumio volumio[6454]: ---------------------------- MPD announces state update: update May 11 21:19:25 volumio volumio[6454]: info: ControllerMpd::getState May 11 21:19:25 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand status May 11 21:19:25 volumio volumio[6454]: info: sendMpdCommand status took 5 milliseconds May 11 21:19:25 volumio volumio[6454]: info: sendMpdCommand status took 4 milliseconds May 11 21:19:25 volumio volumio[6454]: info: sendMpdCommand status took 4 milliseconds May 11 21:19:25 volumio volumio[6454]: info: sendMpdCommand status took 3 milliseconds May 11 21:19:25 volumio volumio[6454]: info: sendMpdCommand status took 3 milliseconds May 11 21:19:25 volumio volumio[6454]: info: sendMpdCommand status took 2 milliseconds May 11 21:19:25 volumio volumio[6454]: verbose: ControllerMpd::parseState May 11 21:19:25 volumio volumio[6454]: info: Command Router : Notfying DB Updatetrue May 11 21:19:25 volumio volumio[6454]: info: CoreCommandRouter::Close All Modals sent May 11 21:19:25 volumio volumio[6454]: verbose: ControllerMpd::parseState May 11 21:19:25 volumio volumio[6454]: verbose: ControllerMpd::parseState May 11 21:19:25 volumio volumio[6454]: info: Command Router : Notfying DB Updatetrue May 11 21:19:25 volumio volumio[6454]: info: CoreCommandRouter::Close All Modals sent May 11 21:19:25 volumio volumio[6454]: verbose: ControllerMpd::parseState May 11 21:19:25 volumio volumio[6454]: verbose: ControllerMpd::parseState May 11 21:19:25 volumio volumio[6454]: info: Command Router : Notfying DB Updatetrue May 11 21:19:25 volumio volumio[6454]: info: CoreCommandRouter::Close All Modals sent May 11 21:19:25 volumio volumio[6454]: verbose: ControllerMpd::parseState May 11 21:19:26 volumio volumio[6454]: info: ControllerMpd::pushState May 11 21:19:26 volumio volumio[6454]: info: CoreCommandRouter::servicePushState May 11 21:19:26 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:19:26 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:19:26 volumio volumio[6454]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 11 21:19:26 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:19:26 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:19:26 volumio volumio[6454]: 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} May 11 21:19:26 volumio volumio[6454]: verbose: CURRENT POSITION 0 May 11 21:19:26 volumio volumio[6454]: info: CoreStateMachine::syncState stateService stop May 11 21:19:26 volumio volumio[6454]: info: CoreStateMachine::syncState currentStatus stop May 11 21:19:26 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:19:26 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:19:26 volumio volumio[6454]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 11 21:19:26 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:19:26 volumio volumio[6454]: info: No code May 11 21:19:26 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:19:26 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:19:26 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:19:26 volumio volumio[6454]: info: ControllerMpd::pushState May 11 21:19:26 volumio volumio[6454]: info: CoreCommandRouter::servicePushState May 11 21:19:26 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:19:26 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:19:26 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:19:26 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:19:26 volumio volumio[6454]: 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} May 11 21:19:26 volumio volumio[6454]: verbose: CURRENT POSITION 0 May 11 21:19:26 volumio volumio[6454]: info: CoreStateMachine::syncState stateService stop May 11 21:19:26 volumio volumio[6454]: info: CoreStateMachine::syncState currentStatus stop May 11 21:19:26 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:19:26 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:19:26 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:19:26 volumio volumio[6454]: info: No code May 11 21:19:26 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:19:26 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:19:26 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:19:26 volumio volumio[6454]: info: ControllerMpd::pushState May 11 21:19:26 volumio volumio[6454]: info: CoreCommandRouter::servicePushState May 11 21:19:26 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:19:26 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:19:26 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:19:26 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:19:26 volumio volumio[6454]: 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} May 11 21:19:26 volumio volumio[6454]: verbose: CURRENT POSITION 0 May 11 21:19:26 volumio volumio[6454]: info: CoreStateMachine::syncState stateService stop May 11 21:19:26 volumio volumio[6454]: info: CoreStateMachine::syncState currentStatus stop May 11 21:19:26 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:19:26 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:19:26 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:19:26 volumio volumio[6454]: info: No code May 11 21:19:26 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:19:26 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:19:26 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:19:26 volumio volumio[6454]: info: ------------------------------ 78ms May 11 21:19:26 volumio volumio[6454]: info: ------------------------------ 76ms May 11 21:19:26 volumio volumio[6454]: info: ------------------------------ 75ms May 11 21:19:26 volumio volumio[6454]: info: [1715433566025] Database update started May 11 21:19:26 volumio volumio[6454]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 11 21:19:26 volumio volumio[6454]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 11 21:19:30 volumio volumio[6454]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 11 21:19:30 volumio nmbd[725]: [2024/05/11 21:19:30.810327, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) May 11 21:19:30 volumio nmbd[725]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.5.16 for name WORKGROUP<1d>. May 11 21:19:30 volumio nmbd[725]: This response was from IP 192.168.5.1, reporting an IP address of 192.168.5.1. May 11 21:19:35 volumio volumio[6454]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 11 21:19:35 volumio volumio[6454]: info: CURURI: albums:// May 11 21:19:35 volumio volumio[6454]: info: listAlbums - loading Albums from cache May 11 21:19:35 volumio volumio[6454]: info: Preload queue cleared May 11 21:19:49 volumio volumio[6454]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 11 21:19:49 volumio volumio[6454]: info: CURURI: albums:// May 11 21:19:49 volumio volumio[6454]: info: listAlbums - loading Albums from cache May 11 21:19:49 volumio volumio[6454]: info: Preload queue cleared May 11 21:19:52 volumio sudo[6894]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 11 21:19:52 volumio sudo[6894]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 21:19:52 volumio sudo[6894]: pam_unix(sudo:session): session closed for user root May 11 21:19:52 volumio sudo[6896]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 11 21:19:52 volumio sudo[6896]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 21:19:52 volumio sudo[6896]: pam_unix(sudo:session): session closed for user root May 11 21:19:52 volumio volumio[6454]: verbose: New Socket.io Connection to 192.168.5.16 from 192.168.5.5 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 17_4_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Total Clients: 5 May 11 21:19:52 volumio volumio[6454]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 11 21:19:52 volumio volumio[6454]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 11 21:19:52 volumio volumio[6454]: info: CoreCommandRouter::volumioGetVisibleSources May 11 21:19:52 volumio volumio[6454]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 11 21:19:52 volumio volumio[6454]: info: CoreCommandRouter::volumioGetState May 11 21:19:52 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:19:52 volumio volumio[6454]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 11 21:19:52 volumio volumio[6454]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 11 21:19:52 volumio volumio[6454]: info: Received Get System Info May 11 21:19:52 volumio volumio[6454]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 11 21:19:52 volumio volumio[6454]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 11 21:19:52 volumio volumio[6454]: info: Discovery: Getting this device information May 11 21:19:52 volumio volumio[6454]: info: CoreCommandRouter::volumioGetState May 11 21:19:52 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:19:52 volumio volumio[6454]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 11 21:19:52 volumio volumio[6454]: info: CoreCommandRouter::volumioGetState May 11 21:19:52 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:19:52 volumio volumio[6454]: info: Listing playlists May 11 21:19:52 volumio volumio[6454]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 11 21:19:52 volumio volumio[6454]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 11 21:19:53 volumio volumio[6454]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 11 21:19:53 volumio volumio[6454]: info: Received Get System Info May 11 21:19:53 volumio volumio[6454]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 11 21:19:53 volumio volumio[6454]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 11 21:19:53 volumio volumio[6454]: info: Discovery: Getting this device information May 11 21:19:53 volumio volumio[6454]: info: CoreCommandRouter::volumioGetState May 11 21:19:53 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:19:53 volumio volumio[6454]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 11 21:19:56 volumio volumio[6454]: info: CoreCommandRouter::volumioGetQueue May 11 21:19:56 volumio volumio[6454]: info: CoreStateMachine::getQueue May 11 21:19:56 volumio volumio[6454]: info: CorePlayQueue::getQueue May 11 21:20:04 volumio volumio[6454]: info: CoreCommandRouter::getUIConfigOnPlugin May 11 21:20:04 volumio volumio[6454]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 11 21:20:04 volumio volumio[6454]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 11 21:20:04 volumio volumio[6454]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 11 21:20:04 volumio volumio[6454]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 11 21:20:04 volumio volumio[6454]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 11 21:20:04 volumio volumio[6454]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 11 21:20:04 volumio volumio[6454]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 11 21:20:04 volumio volumio[6454]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 11 21:20:04 volumio volumio[6454]: info: CoreCommandRouter::volumioGetBrowseSources May 11 21:20:04 volumio volumio[6454]: info: CoreCommandRouter::volumioGetBrowseSources May 11 21:20:04 volumio volumio[6454]: info: CoreCommandRouter::volumioGetBrowseSources May 11 21:20:04 volumio volumio[6454]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 11 21:20:04 volumio volumio[6454]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 11 21:20:08 volumio volumio[6454]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 11 21:20:08 volumio volumio[6454]: info: CURURI: genres:// May 11 21:20:08 volumio volumio[6454]: info: Preload queue cleared May 11 21:20:09 volumio volumio[6454]: info: MPD Database updated - AlbumList cache refreshed May 11 21:20:09 volumio volumio[6454]: info: May 11 21:20:09 volumio volumio[6454]: ---------------------------- MPD announces state update: database May 11 21:20:09 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand status May 11 21:20:09 volumio volumio[6454]: info: May 11 21:20:09 volumio volumio[6454]: ---------------------------- MPD announces state update: update May 11 21:20:09 volumio volumio[6454]: info: ControllerMpd::getState May 11 21:20:09 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand status May 11 21:20:09 volumio volumio[6454]: info: ControllerMpd::getState May 11 21:20:09 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand status May 11 21:20:09 volumio volumio[6454]: info: MPD Database updated - AlbumList cache refreshed May 11 21:20:09 volumio volumio[6454]: info: May 11 21:20:09 volumio volumio[6454]: ---------------------------- MPD announces state update: database May 11 21:20:09 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand status May 11 21:20:09 volumio volumio[6454]: info: May 11 21:20:09 volumio volumio[6454]: ---------------------------- MPD announces state update: update May 11 21:20:09 volumio volumio[6454]: info: ControllerMpd::getState May 11 21:20:09 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand status May 11 21:20:09 volumio volumio[6454]: info: ControllerMpd::getState May 11 21:20:09 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand status May 11 21:20:09 volumio volumio[6454]: info: MPD Database updated - AlbumList cache refreshed May 11 21:20:09 volumio volumio[6454]: info: May 11 21:20:09 volumio volumio[6454]: ---------------------------- MPD announces state update: database May 11 21:20:09 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand status May 11 21:20:09 volumio volumio[6454]: info: May 11 21:20:09 volumio volumio[6454]: ---------------------------- MPD announces state update: update May 11 21:20:09 volumio volumio[6454]: info: ControllerMpd::getState May 11 21:20:09 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand status May 11 21:20:09 volumio volumio[6454]: info: ControllerMpd::getState May 11 21:20:09 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand status May 11 21:20:09 volumio volumio[6454]: info: sendMpdCommand status took 8 milliseconds May 11 21:20:09 volumio volumio[6454]: info: sendMpdCommand status took 8 milliseconds May 11 21:20:09 volumio volumio[6454]: info: sendMpdCommand status took 8 milliseconds May 11 21:20:09 volumio volumio[6454]: verbose: ControllerMpd::parseState May 11 21:20:09 volumio volumio[6454]: info: Command Router : Notfying DB Updatefalse May 11 21:20:09 volumio volumio[6454]: info: CoreCommandRouter::Close All Modals sent May 11 21:20:09 volumio volumio[6454]: verbose: ControllerMpd::parseState May 11 21:20:09 volumio volumio[6454]: verbose: ControllerMpd::parseState May 11 21:20:09 volumio volumio[6454]: info: ControllerMpd::pushState May 11 21:20:09 volumio volumio[6454]: info: CoreCommandRouter::servicePushState May 11 21:20:09 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:20:09 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:20:09 volumio volumio[6454]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 11 21:20:09 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:20:09 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:20:09 volumio volumio[6454]: 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 11 21:20:09 volumio volumio[6454]: verbose: CURRENT POSITION 0 May 11 21:20:09 volumio volumio[6454]: info: CoreStateMachine::syncState stateService stop May 11 21:20:09 volumio volumio[6454]: info: CoreStateMachine::syncState currentStatus stop May 11 21:20:09 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:20:09 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:20:09 volumio volumio[6454]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 11 21:20:09 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:20:09 volumio volumio[6454]: info: No code May 11 21:20:09 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:20:09 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:20:09 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:20:09 volumio volumio[6454]: info: ControllerMpd::pushState May 11 21:20:09 volumio volumio[6454]: info: CoreCommandRouter::servicePushState May 11 21:20:09 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:20:09 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:20:09 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:20:09 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:20:09 volumio volumio[6454]: 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 11 21:20:09 volumio volumio[6454]: verbose: CURRENT POSITION 0 May 11 21:20:09 volumio volumio[6454]: info: CoreStateMachine::syncState stateService stop May 11 21:20:09 volumio volumio[6454]: info: CoreStateMachine::syncState currentStatus stop May 11 21:20:09 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:20:09 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:20:09 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:20:09 volumio volumio[6454]: info: No code May 11 21:20:09 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:20:09 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:20:09 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:20:09 volumio volumio[6454]: info: ------------------------------ 34ms May 11 21:20:09 volumio volumio[6454]: info: ------------------------------ 34ms May 11 21:20:09 volumio volumio[6454]: info: sendMpdCommand status took 39 milliseconds May 11 21:20:09 volumio volumio[6454]: info: sendMpdCommand status took 40 milliseconds May 11 21:20:09 volumio volumio[6454]: info: sendMpdCommand status took 40 milliseconds May 11 21:20:09 volumio volumio[6454]: verbose: ControllerMpd::parseState May 11 21:20:09 volumio volumio[6454]: info: Command Router : Notfying DB Updatefalse May 11 21:20:09 volumio volumio[6454]: info: CoreCommandRouter::Close All Modals sent May 11 21:20:09 volumio volumio[6454]: verbose: ControllerMpd::parseState May 11 21:20:09 volumio volumio[6454]: verbose: ControllerMpd::parseState May 11 21:20:09 volumio volumio[6454]: info: ControllerMpd::pushState May 11 21:20:09 volumio volumio[6454]: info: CoreCommandRouter::servicePushState May 11 21:20:09 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:20:09 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:20:09 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:20:09 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:20:09 volumio volumio[6454]: 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 11 21:20:09 volumio volumio[6454]: verbose: CURRENT POSITION 0 May 11 21:20:09 volumio volumio[6454]: info: CoreStateMachine::syncState stateService stop May 11 21:20:09 volumio volumio[6454]: info: CoreStateMachine::syncState currentStatus stop May 11 21:20:09 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:20:09 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:20:09 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:20:09 volumio volumio[6454]: info: No code May 11 21:20:09 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:20:09 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:20:09 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:20:09 volumio volumio[6454]: info: ControllerMpd::pushState May 11 21:20:09 volumio volumio[6454]: info: CoreCommandRouter::servicePushState May 11 21:20:09 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:20:09 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:20:09 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:20:09 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:20:09 volumio volumio[6454]: 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 11 21:20:09 volumio volumio[6454]: verbose: CURRENT POSITION 0 May 11 21:20:09 volumio volumio[6454]: info: CoreStateMachine::syncState stateService stop May 11 21:20:09 volumio volumio[6454]: info: CoreStateMachine::syncState currentStatus stop May 11 21:20:09 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:20:09 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:20:09 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:20:09 volumio volumio[6454]: info: No code May 11 21:20:09 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:20:09 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:20:09 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:20:09 volumio volumio[6454]: info: ------------------------------ 64ms May 11 21:20:09 volumio volumio[6454]: info: ------------------------------ 64ms May 11 21:20:09 volumio volumio[6454]: info: sendMpdCommand status took 71 milliseconds May 11 21:20:09 volumio volumio[6454]: info: sendMpdCommand status took 71 milliseconds May 11 21:20:09 volumio volumio[6454]: info: sendMpdCommand status took 71 milliseconds May 11 21:20:09 volumio volumio[6454]: verbose: ControllerMpd::parseState May 11 21:20:09 volumio volumio[6454]: info: Command Router : Notfying DB Updatefalse May 11 21:20:09 volumio volumio[6454]: info: CoreCommandRouter::Close All Modals sent May 11 21:20:09 volumio volumio[6454]: verbose: ControllerMpd::parseState May 11 21:20:09 volumio volumio[6454]: verbose: ControllerMpd::parseState May 11 21:20:09 volumio volumio[6454]: info: ControllerMpd::pushState May 11 21:20:09 volumio volumio[6454]: info: CoreCommandRouter::servicePushState May 11 21:20:09 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:20:09 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:20:09 volumio volumio[6454]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 11 21:20:09 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:20:09 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:20:09 volumio volumio[6454]: 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 11 21:20:09 volumio volumio[6454]: verbose: CURRENT POSITION 0 May 11 21:20:09 volumio volumio[6454]: info: CoreStateMachine::syncState stateService stop May 11 21:20:09 volumio volumio[6454]: info: CoreStateMachine::syncState currentStatus stop May 11 21:20:09 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:20:09 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:20:09 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:20:09 volumio volumio[6454]: info: No code May 11 21:20:09 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:20:09 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:20:09 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:20:09 volumio volumio[6454]: info: ControllerMpd::pushState May 11 21:20:09 volumio volumio[6454]: info: CoreCommandRouter::servicePushState May 11 21:20:09 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:20:09 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:20:09 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:20:09 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:20:09 volumio volumio[6454]: 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 11 21:20:09 volumio volumio[6454]: verbose: CURRENT POSITION 0 May 11 21:20:09 volumio volumio[6454]: info: CoreStateMachine::syncState stateService stop May 11 21:20:09 volumio volumio[6454]: info: CoreStateMachine::syncState currentStatus stop May 11 21:20:09 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:20:09 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:20:09 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:20:09 volumio volumio[6454]: info: No code May 11 21:20:09 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:20:09 volumio volumio[6454]: info: CorePlayQueue::getTrack 0 May 11 21:20:09 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:20:09 volumio volumio[6454]: info: ------------------------------ 96ms May 11 21:20:09 volumio volumio[6454]: info: ------------------------------ 96ms May 11 21:20:11 volumio volumio[6454]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 11 21:20:11 volumio volumio[6454]: info: CURURI: albums:// May 11 21:20:11 volumio volumio[6454]: info: listAlbums - loading Albums from cache May 11 21:20:12 volumio volumio[6454]: info: Preload queue cleared May 11 21:20:12 volumio volumio[6454]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/*/64e96f92-ffe1-4772-bc13-4f11351cd3c2.jpg' May 11 21:20:12 volumio volumio[6454]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found May 11 21:20:12 volumio volumio[6454]: at SendStream.error (/volumio/node_modules/send/index.js:270:31) May 11 21:20:12 volumio volumio[6454]: at SendStream.pipe (/volumio/node_modules/send/index.js:584:14) May 11 21:20:12 volumio volumio[6454]: at sendfile (/volumio/node_modules/express/lib/response.js:1103:8) May 11 21:20:12 volumio volumio[6454]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:433:3) May 11 21:20:12 volumio volumio[6454]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:440:9) May 11 21:20:12 volumio volumio[6454]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) May 11 21:20:12 volumio volumio[6454]: at processTicksAndRejections (internal/process/task_queues.js:77:11) May 11 21:20:13 volumio volumio[6454]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found May 11 21:20:13 volumio volumio[6454]: at SendStream.error (/volumio/node_modules/send/index.js:270:31) May 11 21:20:13 volumio volumio[6454]: at SendStream.pipe (/volumio/node_modules/send/index.js:584:14) May 11 21:20:13 volumio volumio[6454]: at sendfile (/volumio/node_modules/express/lib/response.js:1103:8) May 11 21:20:13 volumio volumio[6454]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:433:3) May 11 21:20:13 volumio volumio[6454]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:440:9) May 11 21:20:13 volumio volumio[6454]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) May 11 21:20:13 volumio volumio[6454]: at processTicksAndRejections (internal/process/task_queues.js:77:11) May 11 21:20:13 volumio volumio[6454]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/2CELLOS/Score/b10cec0d-9528-48a6-a6c5-ca3ebe1c5164.png' May 11 21:20:15 volumio volumio[6454]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/James%20Horner/Titanic%3A%20Original%20Motion%20Picture%20Soundtrack%20-%20Collector%27s%20Anniversary%20Edition/46ea1383-5623-44f5-9ee6-736b95b7ad33.jpg' May 11 21:20:16 volumio volumio[6454]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found May 11 21:20:16 volumio volumio[6454]: at SendStream.error (/volumio/node_modules/send/index.js:270:31) May 11 21:20:16 volumio volumio[6454]: at SendStream.pipe (/volumio/node_modules/send/index.js:584:14) May 11 21:20:16 volumio volumio[6454]: at sendfile (/volumio/node_modules/express/lib/response.js:1103:8) May 11 21:20:16 volumio volumio[6454]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:433:3) May 11 21:20:16 volumio volumio[6454]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:440:9) May 11 21:20:16 volumio volumio[6454]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) May 11 21:20:16 volumio volumio[6454]: at processTicksAndRejections (internal/process/task_queues.js:77:11) May 11 21:20:16 volumio volumio[6454]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found May 11 21:20:16 volumio volumio[6454]: at SendStream.error (/volumio/node_modules/send/index.js:270:31) May 11 21:20:16 volumio volumio[6454]: at SendStream.pipe (/volumio/node_modules/send/index.js:584:14) May 11 21:20:16 volumio volumio[6454]: at sendfile (/volumio/node_modules/express/lib/response.js:1103:8) May 11 21:20:16 volumio volumio[6454]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:433:3) May 11 21:20:16 volumio volumio[6454]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:440:9) May 11 21:20:16 volumio volumio[6454]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) May 11 21:20:16 volumio volumio[6454]: at processTicksAndRejections (internal/process/task_queues.js:77:11) May 11 21:20:28 volumio volumio[6454]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 11 21:20:28 volumio volumio[6454]: info: CURURI: albums://HAUSER/Classic May 11 21:20:28 volumio volumio[6454]: info: Preload queue cleared May 11 21:20:28 volumio volumio[6454]: info: Preloading song: music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/01.HAUSER - 天鹅湖.flac May 11 21:20:28 volumio volumio[6454]: info: Preloading song: music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/02.HAUSER - 拉赫玛尼诺夫第二钢琴协奏曲.flac May 11 21:20:28 volumio volumio[6454]: info: Preloading song: music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/03.HAUSER - 卡鲁索 (Caruso).flac May 11 21:20:28 volumio volumio[6454]: info: Preloading song: music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/04.HAUSER - G弦上的咏叹调.flac May 11 21:20:28 volumio volumio[6454]: info: Preloading song: music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/05.HAUSER - 胡桃夹子组曲.flac May 11 21:20:28 volumio volumio[6454]: info: Preloading song: music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/06.HAUSER - 单簧管协奏曲.flac May 11 21:20:28 volumio volumio[6454]: info: Preloading song: music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/07.HAUSER - 升C大调夜曲.flac May 11 21:20:28 volumio volumio[6454]: info: Preloading song: music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/08.HAUSER - 间奏曲 (乡村骑士).flac May 11 21:20:28 volumio volumio[6454]: info: Preloading song: music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/09.HAUSER - River Flows in You.flac May 11 21:20:28 volumio volumio[6454]: info: Preloading song: music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/10.HAUSER - 让我哭泣 (Lascia Ch' io Pianga).flac May 11 21:20:28 volumio volumio[6454]: info: Preloading song: music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/11.HAUSER - 孤独的牧羊人.flac May 11 21:20:28 volumio volumio[6454]: info: Preloading song: music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/12.HAUSER - 钢琴协奏曲 No. 21.flac May 11 21:20:28 volumio volumio[6454]: info: Preloading song: music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/13.HAUSER - 夜曲.flac May 11 21:20:28 volumio volumio[6454]: info: Preloading song: music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/14.HAUSER - 今夜无人入睡.flac May 11 21:20:28 volumio volumio[6454]: info: Preloading song: music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/15.HAUSER - 以泪洗面 (Lacrimosa).flac May 11 21:20:28 volumio volumio[6454]: info: Preloading song: music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/16.HAUSER - 为弦乐而作的柔板.flac May 11 21:20:28 volumio volumio[6454]: info: Exploding uri music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/01.HAUSER - 天鹅湖.flac in service mpd May 11 21:20:28 volumio volumio[6454]: info: Exploding uri music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/02.HAUSER - 拉赫玛尼诺夫第二钢琴协奏曲.flac in service mpd May 11 21:20:28 volumio volumio[6454]: info: Exploding uri music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/03.HAUSER - 卡鲁索 (Caruso).flac in service mpd May 11 21:20:28 volumio volumio[6454]: info: ALBUMART /albumart?cacheid=94&web=HAUSER/Classic/extralarge&path=%2Fmnt%2FNAS%2Frouter%2FMusic%2FHauser-%E7%BB%8F%E5%85%B8%E4%B9%8B%E5%A3%B0%EF%BC%88Hi-Res%20FLAC%2096kHz24bit%EF%BC%89%2F01.HAUSER%20-%20%E5%A4%A9%E9%B9%85%E6%B9%96.flac&metadata=false May 11 21:20:28 volumio volumio[6454]: info: URI /mnt/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/01.HAUSER - 天鹅湖.flac May 11 21:20:28 volumio volumio[6454]: info: ALBUMART /albumart?cacheid=94&web=HAUSER/Classic/extralarge&path=%2Fmnt%2FNAS%2Frouter%2FMusic%2FHauser-%E7%BB%8F%E5%85%B8%E4%B9%8B%E5%A3%B0%EF%BC%88Hi-Res%20FLAC%2096kHz24bit%EF%BC%89%2F02.HAUSER%20-%20%E6%8B%89%E8%B5%AB%E7%8E%9B%E5%B0%BC%E8%AF%BA%E5%A4%AB%E7%AC%AC%E4%BA%8C%E9%92%A2%E7%90%B4%E5%8D%8F%E5%A5%8F%E6%9B%B2.flac&metadata=false May 11 21:20:28 volumio volumio[6454]: info: URI /mnt/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/02.HAUSER - 拉赫玛尼诺夫第二钢琴协奏曲.flac May 11 21:20:28 volumio volumio[6454]: info: ALBUMART /albumart?cacheid=94&web=HAUSER/Classic/extralarge&path=%2Fmnt%2FNAS%2Frouter%2FMusic%2FHauser-%E7%BB%8F%E5%85%B8%E4%B9%8B%E5%A3%B0%EF%BC%88Hi-Res%20FLAC%2096kHz24bit%EF%BC%89%2F03.HAUSER%20-%20%E5%8D%A1%E9%B2%81%E7%B4%A2%20(Caruso).flac&metadata=false May 11 21:20:28 volumio volumio[6454]: info: URI /mnt/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/03.HAUSER - 卡鲁索 (Caruso).flac May 11 21:20:28 volumio volumio[6454]: info: Exploding uri music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/04.HAUSER - G弦上的咏叹调.flac in service mpd May 11 21:20:28 volumio volumio[6454]: info: ALBUMART /albumart?cacheid=94&web=HAUSER/Classic/extralarge&path=%2Fmnt%2FNAS%2Frouter%2FMusic%2FHauser-%E7%BB%8F%E5%85%B8%E4%B9%8B%E5%A3%B0%EF%BC%88Hi-Res%20FLAC%2096kHz24bit%EF%BC%89%2F04.HAUSER%20-%20G%E5%BC%A6%E4%B8%8A%E7%9A%84%E5%92%8F%E5%8F%B9%E8%B0%83.flac&metadata=false May 11 21:20:28 volumio volumio[6454]: info: URI /mnt/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/04.HAUSER - G弦上的咏叹调.flac May 11 21:20:28 volumio volumio[6454]: info: Exploding uri music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/05.HAUSER - 胡桃夹子组曲.flac in service mpd May 11 21:20:28 volumio volumio[6454]: info: ALBUMART /albumart?cacheid=94&web=HAUSER/Classic/extralarge&path=%2Fmnt%2FNAS%2Frouter%2FMusic%2FHauser-%E7%BB%8F%E5%85%B8%E4%B9%8B%E5%A3%B0%EF%BC%88Hi-Res%20FLAC%2096kHz24bit%EF%BC%89%2F05.HAUSER%20-%20%E8%83%A1%E6%A1%83%E5%A4%B9%E5%AD%90%E7%BB%84%E6%9B%B2.flac&metadata=false May 11 21:20:28 volumio volumio[6454]: info: URI /mnt/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/05.HAUSER - 胡桃夹子组曲.flac May 11 21:20:28 volumio volumio[6454]: info: No valid Plugin REST Endpoint May 11 21:20:28 volumio volumio[6454]: info: No valid Plugin REST Endpoint May 11 21:20:29 volumio volumio[6454]: info: Exploding uri music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/06.HAUSER - 单簧管协奏曲.flac in service mpd May 11 21:20:29 volumio volumio[6454]: info: ALBUMART /albumart?cacheid=94&web=HAUSER/Classic/extralarge&path=%2Fmnt%2FNAS%2Frouter%2FMusic%2FHauser-%E7%BB%8F%E5%85%B8%E4%B9%8B%E5%A3%B0%EF%BC%88Hi-Res%20FLAC%2096kHz24bit%EF%BC%89%2F06.HAUSER%20-%20%E5%8D%95%E7%B0%A7%E7%AE%A1%E5%8D%8F%E5%A5%8F%E6%9B%B2.flac&metadata=false May 11 21:20:29 volumio volumio[6454]: info: URI /mnt/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/06.HAUSER - 单簧管协奏曲.flac May 11 21:20:29 volumio volumio[6454]: info: Exploding uri music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/07.HAUSER - 升C大调夜曲.flac in service mpd May 11 21:20:29 volumio volumio[6454]: info: ALBUMART /albumart?cacheid=94&web=HAUSER/Classic/extralarge&path=%2Fmnt%2FNAS%2Frouter%2FMusic%2FHauser-%E7%BB%8F%E5%85%B8%E4%B9%8B%E5%A3%B0%EF%BC%88Hi-Res%20FLAC%2096kHz24bit%EF%BC%89%2F07.HAUSER%20-%20%E5%8D%87C%E5%A4%A7%E8%B0%83%E5%A4%9C%E6%9B%B2.flac&metadata=false May 11 21:20:29 volumio volumio[6454]: info: URI /mnt/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/07.HAUSER - 升C大调夜曲.flac May 11 21:20:29 volumio volumio[6454]: info: Exploding uri music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/08.HAUSER - 间奏曲 (乡村骑士).flac in service mpd May 11 21:20:29 volumio volumio[6454]: info: ALBUMART /albumart?cacheid=94&web=HAUSER/Classic/extralarge&path=%2Fmnt%2FNAS%2Frouter%2FMusic%2FHauser-%E7%BB%8F%E5%85%B8%E4%B9%8B%E5%A3%B0%EF%BC%88Hi-Res%20FLAC%2096kHz24bit%EF%BC%89%2F08.HAUSER%20-%20%E9%97%B4%E5%A5%8F%E6%9B%B2%20(%E4%B9%A1%E6%9D%91%E9%AA%91%E5%A3%AB).flac&metadata=false May 11 21:20:29 volumio volumio[6454]: info: URI /mnt/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/08.HAUSER - 间奏曲 (乡村骑士).flac May 11 21:20:29 volumio volumio[6454]: info: Exploding uri music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/09.HAUSER - River Flows in You.flac in service mpd May 11 21:20:29 volumio volumio[6454]: info: ALBUMART /albumart?cacheid=94&web=HAUSER/Classic/extralarge&path=%2Fmnt%2FNAS%2Frouter%2FMusic%2FHauser-%E7%BB%8F%E5%85%B8%E4%B9%8B%E5%A3%B0%EF%BC%88Hi-Res%20FLAC%2096kHz24bit%EF%BC%89%2F09.HAUSER%20-%20River%20Flows%20in%20You.flac&metadata=false May 11 21:20:29 volumio volumio[6454]: info: URI /mnt/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/09.HAUSER - River Flows in You.flac May 11 21:20:29 volumio volumio[6454]: info: Exploding uri music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/10.HAUSER - 让我哭泣 (Lascia Ch' io Pianga).flac in service mpd May 11 21:20:29 volumio volumio[6454]: info: ALBUMART /albumart?cacheid=94&web=HAUSER/Classic/extralarge&path=%2Fmnt%2FNAS%2Frouter%2FMusic%2FHauser-%E7%BB%8F%E5%85%B8%E4%B9%8B%E5%A3%B0%EF%BC%88Hi-Res%20FLAC%2096kHz24bit%EF%BC%89%2F10.HAUSER%20-%20%E8%AE%A9%E6%88%91%E5%93%AD%E6%B3%A3%20%20(Lascia%20Ch'%20io%20Pianga).flac&metadata=false May 11 21:20:29 volumio volumio[6454]: info: URI /mnt/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/10.HAUSER - 让我哭泣 (Lascia Ch' io Pianga).flac May 11 21:20:29 volumio volumio[6454]: info: Exploding uri music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/11.HAUSER - 孤独的牧羊人.flac in service mpd May 11 21:20:29 volumio volumio[6454]: info: ALBUMART /albumart?cacheid=94&web=HAUSER/Classic/extralarge&path=%2Fmnt%2FNAS%2Frouter%2FMusic%2FHauser-%E7%BB%8F%E5%85%B8%E4%B9%8B%E5%A3%B0%EF%BC%88Hi-Res%20FLAC%2096kHz24bit%EF%BC%89%2F11.HAUSER%20-%20%E5%AD%A4%E7%8B%AC%E7%9A%84%E7%89%A7%E7%BE%8A%E4%BA%BA.flac&metadata=false May 11 21:20:29 volumio volumio[6454]: info: URI /mnt/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/11.HAUSER - 孤独的牧羊人.flac May 11 21:20:29 volumio volumio[6454]: info: Exploding uri music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/12.HAUSER - 钢琴协奏曲 No. 21.flac in service mpd May 11 21:20:29 volumio volumio[6454]: info: ALBUMART /albumart?cacheid=94&web=HAUSER/Classic/extralarge&path=%2Fmnt%2FNAS%2Frouter%2FMusic%2FHauser-%E7%BB%8F%E5%85%B8%E4%B9%8B%E5%A3%B0%EF%BC%88Hi-Res%20FLAC%2096kHz24bit%EF%BC%89%2F12.HAUSER%20-%20%E9%92%A2%E7%90%B4%E5%8D%8F%E5%A5%8F%E6%9B%B2%20No.%2021.flac&metadata=false May 11 21:20:29 volumio volumio[6454]: info: URI /mnt/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/12.HAUSER - 钢琴协奏曲 No. 21.flac May 11 21:20:29 volumio volumio[6454]: info: Exploding uri music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/13.HAUSER - 夜曲.flac in service mpd May 11 21:20:29 volumio volumio[6454]: info: ALBUMART /albumart?cacheid=94&web=HAUSER/Classic/extralarge&path=%2Fmnt%2FNAS%2Frouter%2FMusic%2FHauser-%E7%BB%8F%E5%85%B8%E4%B9%8B%E5%A3%B0%EF%BC%88Hi-Res%20FLAC%2096kHz24bit%EF%BC%89%2F13.HAUSER%20-%20%E5%A4%9C%E6%9B%B2.flac&metadata=false May 11 21:20:29 volumio volumio[6454]: info: URI /mnt/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/13.HAUSER - 夜曲.flac May 11 21:20:29 volumio volumio[6454]: info: Exploding uri music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/14.HAUSER - 今夜无人入睡.flac in service mpd May 11 21:20:29 volumio volumio[6454]: info: ALBUMART /albumart?cacheid=94&web=HAUSER/Classic/extralarge&path=%2Fmnt%2FNAS%2Frouter%2FMusic%2FHauser-%E7%BB%8F%E5%85%B8%E4%B9%8B%E5%A3%B0%EF%BC%88Hi-Res%20FLAC%2096kHz24bit%EF%BC%89%2F14.HAUSER%20-%20%E4%BB%8A%E5%A4%9C%E6%97%A0%E4%BA%BA%E5%85%A5%E7%9D%A1.flac&metadata=false May 11 21:20:29 volumio volumio[6454]: info: URI /mnt/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/14.HAUSER - 今夜无人入睡.flac May 11 21:20:29 volumio volumio[6454]: info: Exploding uri music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/15.HAUSER - 以泪洗面 (Lacrimosa).flac in service mpd May 11 21:20:29 volumio volumio[6454]: info: ALBUMART /albumart?cacheid=94&web=HAUSER/Classic/extralarge&path=%2Fmnt%2FNAS%2Frouter%2FMusic%2FHauser-%E7%BB%8F%E5%85%B8%E4%B9%8B%E5%A3%B0%EF%BC%88Hi-Res%20FLAC%2096kHz24bit%EF%BC%89%2F15.HAUSER%20-%20%E4%BB%A5%E6%B3%AA%E6%B4%97%E9%9D%A2%20(Lacrimosa).flac&metadata=false May 11 21:20:29 volumio volumio[6454]: info: URI /mnt/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/15.HAUSER - 以泪洗面 (Lacrimosa).flac May 11 21:20:29 volumio volumio[6454]: info: Exploding uri music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/16.HAUSER - 为弦乐而作的柔板.flac in service mpd May 11 21:20:29 volumio volumio[6454]: info: ALBUMART /albumart?cacheid=94&web=HAUSER/Classic/extralarge&path=%2Fmnt%2FNAS%2Frouter%2FMusic%2FHauser-%E7%BB%8F%E5%85%B8%E4%B9%8B%E5%A3%B0%EF%BC%88Hi-Res%20FLAC%2096kHz24bit%EF%BC%89%2F16.HAUSER%20-%20%E4%B8%BA%E5%BC%A6%E4%B9%90%E8%80%8C%E4%BD%9C%E7%9A%84%E6%9F%94%E6%9D%BF.flac&metadata=false May 11 21:20:29 volumio volumio[6454]: info: URI /mnt/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/16.HAUSER - 为弦乐而作的柔板.flac May 11 21:20:31 volumio volumio[6454]: info: Preload queue cleared May 11 21:20:31 volumio volumio[6454]: info: CoreCommandRouter::volumioReplaceandPlayItems May 11 21:20:31 volumio volumio[6454]: info: CoreStateMachine::ClearQueue May 11 21:20:31 volumio volumio[6454]: info: CoreStateMachine::stop May 11 21:20:31 volumio volumio[6454]: info: CoreStateMachine::setConsumeUpdateService undefined May 11 21:20:31 volumio volumio[6454]: info: CorePlayQueue::clearPlayQueue May 11 21:20:31 volumio volumio[6454]: info: CorePlayQueue::saveQueue May 11 21:20:31 volumio volumio[6454]: info: CoreCommandRouter::volumioPushQueue May 11 21:20:31 volumio volumio[6454]: info: CoreStateMachine::addQueueItems May 11 21:20:31 volumio volumio[6454]: info: CorePlayQueue::addQueueItems May 11 21:20:31 volumio volumio[6454]: info: Preload queue cleared May 11 21:20:31 volumio volumio[6454]: info: Adding Item to queue: music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/01.HAUSER - 天鹅湖.flac May 11 21:20:31 volumio volumio[6454]: info: Using cached record of: music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/01.HAUSER - 天鹅湖.flac May 11 21:20:31 volumio volumio[6454]: info: Adding Item to queue: music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/02.HAUSER - 拉赫玛尼诺夫第二钢琴协奏曲.flac May 11 21:20:31 volumio volumio[6454]: info: Using cached record of: music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/02.HAUSER - 拉赫玛尼诺夫第二钢琴协奏曲.flac May 11 21:20:31 volumio volumio[6454]: info: Adding Item to queue: music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/03.HAUSER - 卡鲁索 (Caruso).flac May 11 21:20:31 volumio volumio[6454]: info: Using cached record of: music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/03.HAUSER - 卡鲁索 (Caruso).flac May 11 21:20:31 volumio volumio[6454]: info: Adding Item to queue: music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/04.HAUSER - G弦上的咏叹调.flac May 11 21:20:31 volumio volumio[6454]: info: Using cached record of: music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/04.HAUSER - G弦上的咏叹调.flac May 11 21:20:31 volumio volumio[6454]: info: Adding Item to queue: music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/05.HAUSER - 胡桃夹子组曲.flac May 11 21:20:31 volumio volumio[6454]: info: Using cached record of: music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/05.HAUSER - 胡桃夹子组曲.flac May 11 21:20:31 volumio volumio[6454]: info: Adding Item to queue: music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/06.HAUSER - 单簧管协奏曲.flac May 11 21:20:31 volumio volumio[6454]: info: Using cached record of: music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/06.HAUSER - 单簧管协奏曲.flac May 11 21:20:31 volumio volumio[6454]: info: Adding Item to queue: music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/07.HAUSER - 升C大调夜曲.flac May 11 21:20:31 volumio volumio[6454]: info: Using cached record of: music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/07.HAUSER - 升C大调夜曲.flac May 11 21:20:31 volumio volumio[6454]: info: Adding Item to queue: music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/08.HAUSER - 间奏曲 (乡村骑士).flac May 11 21:20:31 volumio volumio[6454]: info: Using cached record of: music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/08.HAUSER - 间奏曲 (乡村骑士).flac May 11 21:20:31 volumio volumio[6454]: info: Adding Item to queue: music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/09.HAUSER - River Flows in You.flac May 11 21:20:31 volumio volumio[6454]: info: Using cached record of: music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/09.HAUSER - River Flows in You.flac May 11 21:20:31 volumio volumio[6454]: info: Adding Item to queue: music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/10.HAUSER - 让我哭泣 (Lascia Ch' io Pianga).flac May 11 21:20:31 volumio volumio[6454]: info: Using cached record of: music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/10.HAUSER - 让我哭泣 (Lascia Ch' io Pianga).flac May 11 21:20:31 volumio volumio[6454]: info: Adding Item to queue: music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/11.HAUSER - 孤独的牧羊人.flac May 11 21:20:31 volumio volumio[6454]: info: Using cached record of: music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/11.HAUSER - 孤独的牧羊人.flac May 11 21:20:31 volumio volumio[6454]: info: Adding Item to queue: music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/12.HAUSER - 钢琴协奏曲 No. 21.flac May 11 21:20:31 volumio volumio[6454]: info: Using cached record of: music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/12.HAUSER - 钢琴协奏曲 No. 21.flac May 11 21:20:31 volumio volumio[6454]: info: Adding Item to queue: music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/13.HAUSER - 夜曲.flac May 11 21:20:31 volumio volumio[6454]: info: Using cached record of: music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/13.HAUSER - 夜曲.flac May 11 21:20:31 volumio volumio[6454]: info: Adding Item to queue: music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/14.HAUSER - 今夜无人入睡.flac May 11 21:20:31 volumio volumio[6454]: info: Using cached record of: music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/14.HAUSER - 今夜无人入睡.flac May 11 21:20:31 volumio volumio[6454]: info: Adding Item to queue: music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/15.HAUSER - 以泪洗面 (Lacrimosa).flac May 11 21:20:31 volumio volumio[6454]: info: Using cached record of: music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/15.HAUSER - 以泪洗面 (Lacrimosa).flac May 11 21:20:31 volumio volumio[6454]: info: Adding Item to queue: music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/16.HAUSER - 为弦乐而作的柔板.flac May 11 21:20:31 volumio volumio[6454]: info: Using cached record of: music-library/NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/16.HAUSER - 为弦乐而作的柔板.flac May 11 21:20:31 volumio volumio[6454]: info: CoreCommandRouter::volumioPushQueue May 11 21:20:31 volumio volumio[6454]: info: CorePlayQueue::saveQueue May 11 21:20:31 volumio volumio[6454]: info: CoreStateMachine::updateTrackBlock May 11 21:20:31 volumio volumio[6454]: info: CorePlayQueue::getTrackBlock May 11 21:20:31 volumio volumio[6454]: info: CoreCommandRouter::volumioPlay May 11 21:20:31 volumio volumio[6454]: info: CoreStateMachine::play index 8 May 11 21:20:31 volumio volumio[6454]: info: CoreStateMachine::setConsumeUpdateService undefined May 11 21:20:31 volumio volumio[6454]: info: CoreStateMachine::stop May 11 21:20:31 volumio volumio[6454]: info: CoreStateMachine::setConsumeUpdateService undefined May 11 21:20:31 volumio volumio[6454]: info: CoreStateMachine::play index undefined May 11 21:20:31 volumio volumio[6454]: info: CoreStateMachine::setConsumeUpdateService undefined May 11 21:20:31 volumio volumio[6454]: info: CorePlayQueue::getTrack 8 May 11 21:20:31 volumio volumio[6454]: info: CoreStateMachine::startPlaybackTimer May 11 21:20:31 volumio volumio[6454]: info: CorePlayQueue::getTrack 8 May 11 21:20:31 volumio volumio[6454]: verbose: ControllerMpd::clearAddPlayTracks NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/09.HAUSER - River Flows in You.flac May 11 21:20:31 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand stop May 11 21:20:31 volumio volumio[6454]: info: sendMpdCommand stop took 1 milliseconds May 11 21:20:31 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand clear May 11 21:20:31 volumio volumio[6454]: info: May 11 21:20:31 volumio volumio[6454]: ---------------------------- MPD announces system playlist update May 11 21:20:31 volumio volumio[6454]: info: Ignoring MPD Status Update May 11 21:20:31 volumio volumio[6454]: info: sendMpdCommand clear took 1 milliseconds May 11 21:20:31 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand add "NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/09.HAUSER - River Flows in You.flac" May 11 21:20:31 volumio volumio[6454]: info: May 11 21:20:31 volumio volumio[6454]: ---------------------------- MPD announces system playlist update May 11 21:20:31 volumio volumio[6454]: info: Ignoring MPD Status Update May 11 21:20:31 volumio volumio[6454]: info: May 11 21:20:31 volumio volumio[6454]: ---------------------------- MPD announces system playlist update May 11 21:20:31 volumio volumio[6454]: info: Ignoring MPD Status Update May 11 21:20:31 volumio volumio[6454]: error: updateQueue error: null May 11 21:20:31 volumio volumio[6454]: info: May 11 21:20:31 volumio volumio[6454]: ---------------------------- MPD announces system playlist update May 11 21:20:31 volumio volumio[6454]: info: Ignoring MPD Status Update May 11 21:20:31 volumio volumio[6454]: info: ------------------------------ 2ms May 11 21:20:31 volumio volumio[6454]: info: sendMpdCommand add "NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/09.HAUSER - River Flows in You.flac" took 2 milliseconds May 11 21:20:31 volumio volumio[6454]: info: ------------------------------ 1ms May 11 21:20:31 volumio volumio[6454]: info: ------------------------------ 1ms May 11 21:20:31 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand play May 11 21:20:31 volumio volumio[6454]: info: May 11 21:20:31 volumio volumio[6454]: ---------------------------- MPD announces system playlist update May 11 21:20:31 volumio volumio[6454]: info: Ignoring MPD Status Update May 11 21:20:31 volumio volumio[6454]: info: May 11 21:20:31 volumio volumio[6454]: ---------------------------- MPD announces system playlist update May 11 21:20:31 volumio volumio[6454]: info: Ignoring MPD Status Update May 11 21:20:31 volumio volumio[6454]: info: ------------------------------ 3ms May 11 21:20:31 volumio volumio[6454]: info: sendMpdCommand play took 1 milliseconds May 11 21:20:31 volumio volumio[6454]: info: ------------------------------ 1ms May 11 21:20:31 volumio volumio[6454]: info: ------------------------------ 1ms May 11 21:20:31 volumio volumio[6454]: info: May 11 21:20:31 volumio volumio[6454]: ---------------------------- MPD announces state update: player May 11 21:20:31 volumio volumio[6454]: info: ControllerMpd::getState May 11 21:20:31 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand status May 11 21:20:31 volumio volumio[6454]: info: May 11 21:20:31 volumio volumio[6454]: ---------------------------- MPD announces state update: player May 11 21:20:31 volumio volumio[6454]: info: ControllerMpd::getState May 11 21:20:31 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand status May 11 21:20:31 volumio volumio[6454]: info: May 11 21:20:31 volumio volumio[6454]: ---------------------------- MPD announces state update: player May 11 21:20:31 volumio volumio[6454]: info: ControllerMpd::getState May 11 21:20:31 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand status May 11 21:20:31 volumio volumio[6454]: info: May 11 21:20:31 volumio volumio[6454]: ---------------------------- MPD announces state update: player May 11 21:20:31 volumio volumio[6454]: info: sendMpdCommand status took 3 milliseconds May 11 21:20:31 volumio volumio[6454]: info: ControllerMpd::getState May 11 21:20:31 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand status May 11 21:20:31 volumio volumio[6454]: verbose: ControllerMpd::parseState May 11 21:20:31 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 11 21:20:31 volumio volumio[6454]: info: sendMpdCommand status took 4 milliseconds May 11 21:20:31 volumio volumio[6454]: info: sendMpdCommand status took 3 milliseconds May 11 21:20:31 volumio volumio[6454]: info: sendMpdCommand status took 1 milliseconds May 11 21:20:31 volumio volumio[6454]: info: sendMpdCommand playlistinfo took 0 milliseconds May 11 21:20:31 volumio volumio[6454]: verbose: ControllerMpd::parseState May 11 21:20:31 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 11 21:20:31 volumio volumio[6454]: verbose: ControllerMpd::parseState May 11 21:20:31 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 11 21:20:31 volumio volumio[6454]: verbose: ControllerMpd::parseState May 11 21:20:31 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 11 21:20:31 volumio volumio[6454]: verbose: ControllerMpd::parseTrackInfo May 11 21:20:31 volumio volumio[6454]: info: ControllerMpd::pushState May 11 21:20:31 volumio volumio[6454]: info: CoreCommandRouter::servicePushState May 11 21:20:31 volumio volumio[6454]: info: CorePlayQueue::getTrack 8 May 11 21:20:31 volumio volumio[6454]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":181,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"River Flows in You","artist":"HAUSER","album":"Classic","uri":"NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/09.HAUSER - River Flows in You.flac","trackType":"flac"} May 11 21:20:31 volumio volumio[6454]: verbose: CURRENT POSITION 8 May 11 21:20:31 volumio volumio[6454]: info: CoreStateMachine::syncState stateService play May 11 21:20:31 volumio volumio[6454]: info: CoreStateMachine::syncState currentStatus stop May 11 21:20:31 volumio volumio[6454]: info: ------------------------------ 5ms May 11 21:20:31 volumio volumio[6454]: info: May 11 21:20:31 volumio volumio[6454]: ---------------------------- MPD announces state update: player May 11 21:20:31 volumio volumio[6454]: info: ControllerMpd::getState May 11 21:20:31 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand status May 11 21:20:31 volumio volumio[6454]: info: May 11 21:20:31 volumio volumio[6454]: ---------------------------- MPD announces state update: player May 11 21:20:31 volumio volumio[6454]: info: ControllerMpd::getState May 11 21:20:31 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand status May 11 21:20:31 volumio volumio[6454]: info: sendMpdCommand playlistinfo took 2 milliseconds May 11 21:20:31 volumio volumio[6454]: info: sendMpdCommand playlistinfo took 2 milliseconds May 11 21:20:31 volumio volumio[6454]: info: sendMpdCommand playlistinfo took 2 milliseconds May 11 21:20:31 volumio volumio[6454]: info: sendMpdCommand status took 1 milliseconds May 11 21:20:31 volumio volumio[6454]: info: sendMpdCommand status took 0 milliseconds May 11 21:20:31 volumio volumio[6454]: verbose: ControllerMpd::parseTrackInfo May 11 21:20:31 volumio volumio[6454]: verbose: ControllerMpd::parseTrackInfo May 11 21:20:31 volumio volumio[6454]: verbose: ControllerMpd::parseTrackInfo May 11 21:20:31 volumio volumio[6454]: verbose: ControllerMpd::parseState May 11 21:20:31 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 11 21:20:31 volumio volumio[6454]: verbose: ControllerMpd::parseState May 11 21:20:31 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 11 21:20:31 volumio volumio[6454]: info: ControllerMpd::pushState May 11 21:20:31 volumio volumio[6454]: info: CoreCommandRouter::servicePushState May 11 21:20:31 volumio volumio[6454]: info: CorePlayQueue::getTrack 8 May 11 21:20:31 volumio volumio[6454]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":181,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"River Flows in You","artist":"HAUSER","album":"Classic","uri":"NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/09.HAUSER - River Flows in You.flac","trackType":"flac"} May 11 21:20:31 volumio volumio[6454]: verbose: CURRENT POSITION 8 May 11 21:20:31 volumio volumio[6454]: info: CoreStateMachine::syncState stateService play May 11 21:20:31 volumio volumio[6454]: info: CoreStateMachine::syncState currentStatus play May 11 21:20:31 volumio volumio[6454]: info: Received an update from plugin. extracting info from payload May 11 21:20:31 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:20:31 volumio volumio[6454]: info: CorePlayQueue::getTrack 8 May 11 21:20:31 volumio volumio[6454]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 11 21:20:31 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:20:31 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:20:31 volumio volumio[6454]: info: CorePlayQueue::getTrack 8 May 11 21:20:31 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:20:31 volumio volumio[6454]: info: ControllerMpd::pushState May 11 21:20:31 volumio volumio[6454]: info: CoreCommandRouter::servicePushState May 11 21:20:31 volumio volumio[6454]: info: CorePlayQueue::getTrack 8 May 11 21:20:31 volumio volumio[6454]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":181,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"River Flows in You","artist":"HAUSER","album":"Classic","uri":"NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/09.HAUSER - River Flows in You.flac","trackType":"flac"} May 11 21:20:31 volumio volumio[6454]: verbose: CURRENT POSITION 8 May 11 21:20:31 volumio volumio[6454]: info: CoreStateMachine::syncState stateService play May 11 21:20:31 volumio volumio[6454]: info: CoreStateMachine::syncState currentStatus play May 11 21:20:31 volumio volumio[6454]: info: Received an update from plugin. extracting info from payload May 11 21:20:31 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:20:31 volumio volumio[6454]: info: CorePlayQueue::getTrack 8 May 11 21:20:31 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:20:31 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:20:31 volumio volumio[6454]: info: CorePlayQueue::getTrack 8 May 11 21:20:31 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:20:31 volumio volumio[6454]: info: ControllerMpd::pushState May 11 21:20:31 volumio volumio[6454]: info: CoreCommandRouter::servicePushState May 11 21:20:31 volumio volumio[6454]: info: CorePlayQueue::getTrack 8 May 11 21:20:31 volumio volumio[6454]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":181,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"River Flows in You","artist":"HAUSER","album":"Classic","uri":"NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/09.HAUSER - River Flows in You.flac","trackType":"flac"} May 11 21:20:31 volumio volumio[6454]: verbose: CURRENT POSITION 8 May 11 21:20:31 volumio volumio[6454]: info: CoreStateMachine::syncState stateService play May 11 21:20:31 volumio volumio[6454]: info: CoreStateMachine::syncState currentStatus play May 11 21:20:31 volumio volumio[6454]: info: Received an update from plugin. extracting info from payload May 11 21:20:31 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:20:31 volumio volumio[6454]: info: CorePlayQueue::getTrack 8 May 11 21:20:31 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:20:31 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:20:31 volumio volumio[6454]: info: CorePlayQueue::getTrack 8 May 11 21:20:31 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:20:31 volumio volumio[6454]: info: ------------------------------ 23ms May 11 21:20:31 volumio volumio[6454]: info: ------------------------------ 22ms May 11 21:20:31 volumio volumio[6454]: info: ------------------------------ 21ms May 11 21:20:31 volumio volumio[6454]: info: sendMpdCommand playlistinfo took 19 milliseconds May 11 21:20:31 volumio volumio[6454]: info: sendMpdCommand playlistinfo took 18 milliseconds May 11 21:20:31 volumio volumio[6454]: verbose: ControllerMpd::parseTrackInfo May 11 21:20:31 volumio volumio[6454]: info: ControllerMpd::pushState May 11 21:20:31 volumio volumio[6454]: info: CoreCommandRouter::servicePushState May 11 21:20:31 volumio volumio[6454]: info: CorePlayQueue::getTrack 8 May 11 21:20:31 volumio volumio[6454]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":181,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"River Flows in You","artist":"HAUSER","album":"Classic","uri":"NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/09.HAUSER - River Flows in You.flac","trackType":"flac"} May 11 21:20:31 volumio volumio[6454]: verbose: CURRENT POSITION 8 May 11 21:20:31 volumio volumio[6454]: info: CoreStateMachine::syncState stateService play May 11 21:20:31 volumio volumio[6454]: info: CoreStateMachine::syncState currentStatus play May 11 21:20:31 volumio volumio[6454]: info: Received an update from plugin. extracting info from payload May 11 21:20:31 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:20:31 volumio volumio[6454]: info: CorePlayQueue::getTrack 8 May 11 21:20:31 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:20:31 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:20:31 volumio volumio[6454]: info: CorePlayQueue::getTrack 8 May 11 21:20:31 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:20:31 volumio volumio[6454]: info: ControllerMpd::pushState May 11 21:20:31 volumio volumio[6454]: info: CoreCommandRouter::servicePushState May 11 21:20:31 volumio volumio[6454]: info: CorePlayQueue::getTrack 8 May 11 21:20:31 volumio volumio[6454]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":181,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"River Flows in You","artist":"HAUSER","album":"Classic","uri":"NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/09.HAUSER - River Flows in You.flac","trackType":"flac"} May 11 21:20:31 volumio volumio[6454]: verbose: CURRENT POSITION 8 May 11 21:20:31 volumio volumio[6454]: info: CoreStateMachine::syncState stateService play May 11 21:20:31 volumio volumio[6454]: info: CoreStateMachine::syncState currentStatus play May 11 21:20:31 volumio volumio[6454]: info: Received an update from plugin. extracting info from payload May 11 21:20:31 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:20:31 volumio volumio[6454]: info: CorePlayQueue::getTrack 8 May 11 21:20:31 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:20:31 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:20:31 volumio volumio[6454]: info: CorePlayQueue::getTrack 8 May 11 21:20:31 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:20:31 volumio volumio[6454]: info: ------------------------------ 34ms May 11 21:20:31 volumio volumio[6454]: info: ------------------------------ 34ms May 11 21:20:33 volumio volumio[6454]: info: CoreCommandRouter::volumioPause May 11 21:20:33 volumio volumio[6454]: info: CoreStateMachine::pause May 11 21:20:33 volumio volumio[6454]: info: CoreStateMachine::stPlaybackTimer May 11 21:20:33 volumio volumio[6454]: info: CoreStateMachine::servicePause May 11 21:20:33 volumio volumio[6454]: info: CorePlayQueue::getTrack 8 May 11 21:20:33 volumio volumio[6454]: info: CoreCommandRouter::servicePause May 11 21:20:33 volumio volumio[6454]: info: ControllerMpd::pause May 11 21:20:33 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand pause May 11 21:20:33 volumio volumio[6454]: info: May 11 21:20:33 volumio volumio[6454]: ---------------------------- MPD announces state update: player May 11 21:20:33 volumio volumio[6454]: info: sendMpdCommand pause took 2 milliseconds May 11 21:20:33 volumio volumio[6454]: info: ControllerMpd::getState May 11 21:20:33 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand status May 11 21:20:33 volumio volumio[6454]: info: May 11 21:20:33 volumio volumio[6454]: ---------------------------- MPD announces state update: player May 11 21:20:33 volumio volumio[6454]: info: ControllerMpd::getState May 11 21:20:33 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand status May 11 21:20:33 volumio volumio[6454]: info: May 11 21:20:33 volumio volumio[6454]: ---------------------------- MPD announces state update: player May 11 21:20:33 volumio volumio[6454]: info: ControllerMpd::getState May 11 21:20:33 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand status May 11 21:20:33 volumio volumio[6454]: info: sendMpdCommand status took 2 milliseconds May 11 21:20:33 volumio volumio[6454]: info: sendMpdCommand status took 2 milliseconds May 11 21:20:33 volumio volumio[6454]: info: sendMpdCommand status took 1 milliseconds May 11 21:20:33 volumio volumio[6454]: verbose: ControllerMpd::parseState May 11 21:20:33 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 11 21:20:33 volumio volumio[6454]: verbose: ControllerMpd::parseState May 11 21:20:33 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 11 21:20:33 volumio volumio[6454]: verbose: ControllerMpd::parseState May 11 21:20:33 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 11 21:20:33 volumio volumio[6454]: info: sendMpdCommand playlistinfo took 2 milliseconds May 11 21:20:33 volumio volumio[6454]: info: sendMpdCommand playlistinfo took 1 milliseconds May 11 21:20:33 volumio volumio[6454]: info: sendMpdCommand playlistinfo took 1 milliseconds May 11 21:20:33 volumio volumio[6454]: verbose: ControllerMpd::parseTrackInfo May 11 21:20:33 volumio volumio[6454]: verbose: ControllerMpd::parseTrackInfo May 11 21:20:33 volumio volumio[6454]: verbose: ControllerMpd::parseTrackInfo May 11 21:20:33 volumio volumio[6454]: info: ControllerMpd::pushState May 11 21:20:33 volumio volumio[6454]: info: CoreCommandRouter::servicePushState May 11 21:20:33 volumio volumio[6454]: info: CorePlayQueue::getTrack 8 May 11 21:20:33 volumio volumio[6454]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":2740,"duration":181,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2560 Kbps","isStreaming":false,"title":"River Flows in You","artist":"HAUSER","album":"Classic","uri":"NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/09.HAUSER - River Flows in You.flac","trackType":"flac"} May 11 21:20:33 volumio volumio[6454]: verbose: CURRENT POSITION 8 May 11 21:20:33 volumio volumio[6454]: info: CoreStateMachine::syncState stateService pause May 11 21:20:33 volumio volumio[6454]: info: CoreStateMachine::syncState currentStatus pause May 11 21:20:33 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:20:33 volumio volumio[6454]: info: CorePlayQueue::getTrack 8 May 11 21:20:33 volumio volumio[6454]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 11 21:20:33 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:20:33 volumio volumio[6454]: info: CoreStateMachine::stPlaybackTimer May 11 21:20:33 volumio volumio[6454]: info: ControllerMpd::pushState May 11 21:20:33 volumio volumio[6454]: info: CoreCommandRouter::servicePushState May 11 21:20:33 volumio volumio[6454]: info: CorePlayQueue::getTrack 8 May 11 21:20:33 volumio volumio[6454]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":2740,"duration":181,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2560 Kbps","isStreaming":false,"title":"River Flows in You","artist":"HAUSER","album":"Classic","uri":"NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/09.HAUSER - River Flows in You.flac","trackType":"flac"} May 11 21:20:33 volumio volumio[6454]: verbose: CURRENT POSITION 8 May 11 21:20:33 volumio volumio[6454]: info: CoreStateMachine::syncState stateService pause May 11 21:20:33 volumio volumio[6454]: info: CoreStateMachine::syncState currentStatus pause May 11 21:20:33 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:20:33 volumio volumio[6454]: info: CorePlayQueue::getTrack 8 May 11 21:20:33 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:20:33 volumio volumio[6454]: info: CoreStateMachine::stPlaybackTimer May 11 21:20:33 volumio volumio[6454]: info: ControllerMpd::pushState May 11 21:20:33 volumio volumio[6454]: info: CoreCommandRouter::servicePushState May 11 21:20:33 volumio volumio[6454]: info: CorePlayQueue::getTrack 8 May 11 21:20:33 volumio volumio[6454]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":2740,"duration":181,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2560 Kbps","isStreaming":false,"title":"River Flows in You","artist":"HAUSER","album":"Classic","uri":"NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/09.HAUSER - River Flows in You.flac","trackType":"flac"} May 11 21:20:33 volumio volumio[6454]: verbose: CURRENT POSITION 8 May 11 21:20:33 volumio volumio[6454]: info: CoreStateMachine::syncState stateService pause May 11 21:20:33 volumio volumio[6454]: info: CoreStateMachine::syncState currentStatus pause May 11 21:20:33 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:20:33 volumio volumio[6454]: info: CorePlayQueue::getTrack 8 May 11 21:20:33 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:20:33 volumio volumio[6454]: info: CoreStateMachine::stPlaybackTimer May 11 21:20:33 volumio volumio[6454]: info: ------------------------------ 17ms May 11 21:20:33 volumio volumio[6454]: info: ------------------------------ 15ms May 11 21:20:33 volumio volumio[6454]: info: ------------------------------ 14ms May 11 21:20:37 volumio volumio[6454]: info: CoreCommandRouter::volumioPlay May 11 21:20:37 volumio volumio[6454]: info: CoreStateMachine::play index undefined May 11 21:20:37 volumio volumio[6454]: info: CoreStateMachine::setConsumeUpdateService undefined May 11 21:20:37 volumio volumio[6454]: info: CorePlayQueue::getTrack 8 May 11 21:20:37 volumio volumio[6454]: info: CoreStateMachine::startPlaybackTimer May 11 21:20:37 volumio volumio[6454]: info: CorePlayQueue::getTrack 8 May 11 21:20:37 volumio volumio[6454]: info: ControllerMpd::resume May 11 21:20:37 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand play May 11 21:20:37 volumio volumio[6454]: info: May 11 21:20:37 volumio volumio[6454]: ---------------------------- MPD announces state update: player May 11 21:20:37 volumio volumio[6454]: info: sendMpdCommand play took 6 milliseconds May 11 21:20:37 volumio volumio[6454]: info: ControllerMpd::getState May 11 21:20:37 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand status May 11 21:20:37 volumio volumio[6454]: info: May 11 21:20:37 volumio volumio[6454]: ---------------------------- MPD announces state update: player May 11 21:20:37 volumio volumio[6454]: info: ControllerMpd::getState May 11 21:20:37 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand status May 11 21:20:37 volumio volumio[6454]: info: May 11 21:20:37 volumio volumio[6454]: ---------------------------- MPD announces state update: player May 11 21:20:37 volumio volumio[6454]: info: ControllerMpd::getState May 11 21:20:37 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand status May 11 21:20:37 volumio volumio[6454]: info: sendMpdCommand status took 1 milliseconds May 11 21:20:37 volumio volumio[6454]: info: sendMpdCommand status took 1 milliseconds May 11 21:20:37 volumio volumio[6454]: info: sendMpdCommand status took 0 milliseconds May 11 21:20:37 volumio volumio[6454]: verbose: ControllerMpd::parseState May 11 21:20:37 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 11 21:20:37 volumio volumio[6454]: verbose: ControllerMpd::parseState May 11 21:20:37 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 11 21:20:37 volumio volumio[6454]: verbose: ControllerMpd::parseState May 11 21:20:37 volumio volumio[6454]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 11 21:20:37 volumio volumio[6454]: info: sendMpdCommand playlistinfo took 1 milliseconds May 11 21:20:37 volumio volumio[6454]: info: sendMpdCommand playlistinfo took 1 milliseconds May 11 21:20:37 volumio volumio[6454]: info: sendMpdCommand playlistinfo took 1 milliseconds May 11 21:20:37 volumio volumio[6454]: verbose: ControllerMpd::parseTrackInfo May 11 21:20:37 volumio volumio[6454]: verbose: ControllerMpd::parseTrackInfo May 11 21:20:37 volumio volumio[6454]: verbose: ControllerMpd::parseTrackInfo May 11 21:20:37 volumio volumio[6454]: info: ControllerMpd::pushState May 11 21:20:37 volumio volumio[6454]: info: CoreCommandRouter::servicePushState May 11 21:20:37 volumio volumio[6454]: info: CorePlayQueue::getTrack 8 May 11 21:20:37 volumio volumio[6454]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3738,"duration":181,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2978 Kbps","isStreaming":false,"title":"River Flows in You","artist":"HAUSER","album":"Classic","uri":"NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/09.HAUSER - River Flows in You.flac","trackType":"flac"} May 11 21:20:37 volumio volumio[6454]: verbose: CURRENT POSITION 8 May 11 21:20:37 volumio volumio[6454]: info: CoreStateMachine::syncState stateService play May 11 21:20:37 volumio volumio[6454]: info: CoreStateMachine::syncState currentStatus pause May 11 21:20:37 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:20:37 volumio volumio[6454]: info: CorePlayQueue::getTrack 8 May 11 21:20:37 volumio volumio[6454]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 11 21:20:37 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:20:37 volumio volumio[6454]: info: ControllerMpd::pushState May 11 21:20:37 volumio volumio[6454]: info: CoreCommandRouter::servicePushState May 11 21:20:37 volumio volumio[6454]: info: CorePlayQueue::getTrack 8 May 11 21:20:37 volumio volumio[6454]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3738,"duration":181,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2978 Kbps","isStreaming":false,"title":"River Flows in You","artist":"HAUSER","album":"Classic","uri":"NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/09.HAUSER - River Flows in You.flac","trackType":"flac"} May 11 21:20:37 volumio volumio[6454]: verbose: CURRENT POSITION 8 May 11 21:20:37 volumio volumio[6454]: info: CoreStateMachine::syncState stateService play May 11 21:20:37 volumio volumio[6454]: info: CoreStateMachine::syncState currentStatus play May 11 21:20:37 volumio volumio[6454]: info: Received an update from plugin. extracting info from payload May 11 21:20:37 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:20:37 volumio volumio[6454]: info: CorePlayQueue::getTrack 8 May 11 21:20:37 volumio volumio[6454]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 11 21:20:37 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:20:37 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:20:37 volumio volumio[6454]: info: CorePlayQueue::getTrack 8 May 11 21:20:37 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:20:37 volumio volumio[6454]: info: ControllerMpd::pushState May 11 21:20:37 volumio volumio[6454]: info: CoreCommandRouter::servicePushState May 11 21:20:37 volumio volumio[6454]: info: CorePlayQueue::getTrack 8 May 11 21:20:37 volumio volumio[6454]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3738,"duration":181,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2978 Kbps","isStreaming":false,"title":"River Flows in You","artist":"HAUSER","album":"Classic","uri":"NAS/router/Music/Hauser-经典之声（Hi-Res FLAC 96kHz24bit）/09.HAUSER - River Flows in You.flac","trackType":"flac"} May 11 21:20:37 volumio volumio[6454]: verbose: CURRENT POSITION 8 May 11 21:20:37 volumio volumio[6454]: info: CoreStateMachine::syncState stateService play May 11 21:20:37 volumio volumio[6454]: info: CoreStateMachine::syncState currentStatus play May 11 21:20:37 volumio volumio[6454]: info: Received an update from plugin. extracting info from payload May 11 21:20:37 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:20:37 volumio volumio[6454]: info: CorePlayQueue::getTrack 8 May 11 21:20:37 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:20:37 volumio volumio[6454]: info: CoreStateMachine::pushState May 11 21:20:37 volumio volumio[6454]: info: CorePlayQueue::getTrack 8 May 11 21:20:37 volumio volumio[6454]: info: CoreCommandRouter::volumioPushState May 11 21:20:37 volumio volumio[6454]: info: ------------------------------ 14ms May 11 21:20:39 volumio volumio[6454]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 11 21:20:39 volumio volumio[6454]: Error: connect ETIMEDOUT 104.244.46.85:443 May 11 21:20:39 volumio volumio[6454]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { May 11 21:20:39 volumio volumio[6454]: errno: -110, May 11 21:20:39 volumio volumio[6454]: code: 'ETIMEDOUT', May 11 21:20:39 volumio volumio[6454]: syscall: 'connect', May 11 21:20:39 volumio volumio[6454]: address: '104.244.46.85', May 11 21:20:39 volumio volumio[6454]: port: 443 May 11 21:20:39 volumio volumio[6454]: } May 11 21:20:39 volumio volumio[6454]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 11 21:20:39 volumio sudo[6994]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-11 21:19 May 11 21:20:39 volumio sudo[6994]: 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="e7445fab547cd22e23d9bef72406cfb610bc1d7d" VOLUMIO_FE_VERSION="5d5e99f8f803b3ec5fc5e8ca13bb4023600f3eee" VOLUMIO_FE3_VERSION="a6ae210575eae1ff43f06ab71e1cd17576840623" VOLUMIO_BE_VERSION="a9e1e1dd6072ffb15c0fcb8938d9ea0d8900c0da" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 24 Apr 2024 02:42:03 PM CEST" VOLUMIO_VERSION="3.661" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="c434411fe8754b648dc7feb1d8f43761"