-- Logs begin at Sun 2025-05-04 16:15:45 UTC, end at Sun 2025-05-04 16:55:36 UTC. -- May 04 16:54:00 volumio kernel: intel ips 0000:00:1f.6: failed to disable graphics turbo May 04 16:54:01 volumio volumio[9401]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 04 16:54:05 volumio kernel: intel ips 0000:00:1f.6: failed to disable graphics turbo May 04 16:54:05 volumio volumio[9401]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 04 16:54:06 volumio volumio[9401]: info: CoreCommandRouter::volumioGetState May 04 16:54:06 volumio volumio[9401]: info: Listing playlists May 04 16:54:06 volumio volumio[9401]: info: Listing playlists May 04 16:54:09 volumio volumio[9401]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 04 16:54:10 volumio volumio[9401]: info: CoreCommandRouter::executeOnPlugin: networkfs , addShare May 04 16:54:10 volumio volumio[9401]: info: Adding a new share May 04 16:54:10 volumio volumio[9401]: info: Share alias is blank May 04 16:54:10 volumio kernel: intel ips 0000:00:1f.6: failed to disable graphics turbo May 04 16:54:13 volumio volumio[9401]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 04 16:54:15 volumio kernel: intel ips 0000:00:1f.6: failed to disable graphics turbo May 04 16:54:16 volumio volumio[9401]: info: CoreCommandRouter::volumioGetState May 04 16:54:17 volumio volumio[9401]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 04 16:54:20 volumio kernel: intel ips 0000:00:1f.6: failed to disable graphics turbo May 04 16:54:21 volumio volumio[9401]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 04 16:54:21 volumio volumio[9401]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares May 04 16:54:21 volumio volumio[9401]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService May 04 16:54:23 volumio volumio[9401]: info: Executing SMB command: smbclient --no-pass --debuglevel=0 -L NAS_LUC.local. May 04 16:54:23 volumio volumio[9401]: info: Executing SMB command: smbclient --no-pass --debuglevel=0 -L iliadbox-Server.local. May 04 16:54:23 volumio volumio[9401]: info: Error browsing device NAS_LUC for shares: Command failed: smbclient --no-pass --debuglevel=0 -L NAS_LUC.local. May 04 16:54:23 volumio volumio[9401]: Unable to initialize messaging context May 04 16:54:25 volumio volumio[9401]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 04 16:54:25 volumio kernel: intel ips 0000:00:1f.6: failed to disable graphics turbo May 04 16:54:26 volumio volumio[9401]: info: CoreCommandRouter::volumioGetState May 04 16:54:26 volumio volumio[9401]: info: Listing playlists May 04 16:54:26 volumio volumio[9401]: info: Listing playlists May 04 16:54:29 volumio volumio[9401]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 04 16:54:31 volumio kernel: intel ips 0000:00:1f.6: failed to disable graphics turbo May 04 16:54:33 volumio volumio[9401]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 04 16:54:36 volumio volumio[9401]: info: CoreCommandRouter::volumioGetState May 04 16:54:36 volumio kernel: intel ips 0000:00:1f.6: failed to disable graphics turbo May 04 16:54:37 volumio volumio[9401]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 04 16:54:41 volumio kernel: intel ips 0000:00:1f.6: failed to disable graphics turbo May 04 16:54:41 volumio volumio[9401]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 04 16:54:45 volumio volumio[9401]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 04 16:54:46 volumio volumio[9401]: info: CoreCommandRouter::volumioGetState May 04 16:54:46 volumio volumio[9401]: info: Listing playlists May 04 16:54:46 volumio volumio[9401]: info: Listing playlists May 04 16:54:46 volumio kernel: intel ips 0000:00:1f.6: failed to disable graphics turbo May 04 16:54:47 volumio volumio[9401]: info: CoreCommandRouter::executeOnPlugin: networkfs , addShare May 04 16:54:47 volumio volumio[9401]: info: Adding a new share May 04 16:54:47 volumio volumio[9401]: info: Share alias is blank May 04 16:54:49 volumio volumio[9401]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 04 16:54:51 volumio kernel: intel ips 0000:00:1f.6: failed to disable graphics turbo May 04 16:54:53 volumio volumio[9401]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 04 16:54:56 volumio volumio[9401]: info: CoreCommandRouter::volumioGetState May 04 16:54:56 volumio volumio[9401]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb May 04 16:54:56 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand rescan May 04 16:54:56 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:54:56 volumio volumio[9401]: info: May 04 16:54:56 volumio volumio[9401]: ---------------------------- MPD announces state update: update May 04 16:54:56 volumio volumio[9401]: info: sendMpdCommand rescan took 2 milliseconds May 04 16:54:56 volumio volumio[9401]: info: ControllerMpd::getState May 04 16:54:56 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:54:56 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:54:56 volumio volumio[9401]: info: May 04 16:54:56 volumio volumio[9401]: ---------------------------- MPD announces state update: update May 04 16:54:56 volumio volumio[9401]: info: ControllerMpd::getState May 04 16:54:56 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:54:56 volumio volumio[9401]: info: May 04 16:54:56 volumio volumio[9401]: ---------------------------- MPD announces state update: update May 04 16:54:56 volumio volumio[9401]: info: ControllerMpd::getState May 04 16:54:56 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:54:56 volumio volumio[9401]: info: May 04 16:54:56 volumio volumio[9401]: ---------------------------- MPD announces state update: update May 04 16:54:56 volumio volumio[9401]: info: ControllerMpd::getState May 04 16:54:56 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:54:56 volumio volumio[9401]: info: sendMpdCommand status took 4 milliseconds May 04 16:54:56 volumio volumio[9401]: info: sendMpdCommand status took 4 milliseconds May 04 16:54:56 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:54:56 volumio volumio[9401]: info: Command Router : Notfying DB Updatefalse May 04 16:54:56 volumio volumio[9401]: info: CoreCommandRouter::Close All Modals sent May 04 16:54:56 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:54:56 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 16:54:56 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:54:56 volumio volumio[9401]: info: May 04 16:54:56 volumio volumio[9401]: ---------------------------- MPD announces state update: update May 04 16:54:56 volumio volumio[9401]: info: ControllerMpd::getState May 04 16:54:56 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:54:56 volumio volumio[9401]: info: sendMpdCommand status took 188 milliseconds May 04 16:54:56 volumio volumio[9401]: info: sendMpdCommand status took 189 milliseconds May 04 16:54:56 volumio volumio[9401]: info: sendMpdCommand status took 188 milliseconds May 04 16:54:56 volumio volumio[9401]: info: sendMpdCommand status took 188 milliseconds May 04 16:54:56 volumio volumio[9401]: info: sendMpdCommand status took 187 milliseconds May 04 16:54:56 volumio volumio[9401]: info: sendMpdCommand status took 187 milliseconds May 04 16:54:56 volumio volumio[9401]: info: sendMpdCommand playlistinfo took 5 milliseconds May 04 16:54:56 volumio volumio[9401]: info: sendMpdCommand status took 3 milliseconds May 04 16:54:56 volumio volumio[9401]: info: sendMpdCommand status took 2 milliseconds May 04 16:54:56 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:54:56 volumio volumio[9401]: info: Command Router : Notfying DB Updatefalse May 04 16:54:56 volumio volumio[9401]: info: CoreCommandRouter::Close All Modals sent May 04 16:54:56 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:54:56 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 16:54:56 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:54:56 volumio volumio[9401]: info: Command Router : Notfying DB Updatefalse May 04 16:54:56 volumio volumio[9401]: info: CoreCommandRouter::Close All Modals sent May 04 16:54:56 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:54:56 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 16:54:56 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:54:56 volumio volumio[9401]: info: Command Router : Notfying DB Updatefalse May 04 16:54:56 volumio volumio[9401]: info: CoreCommandRouter::Close All Modals sent May 04 16:54:56 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:54:56 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 16:54:56 volumio volumio[9401]: verbose: ControllerMpd::parseTrackInfo May 04 16:54:56 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:54:56 volumio volumio[9401]: info: Command Router : Notfying DB Updatefalse May 04 16:54:56 volumio volumio[9401]: info: CoreCommandRouter::Close All Modals sent May 04 16:54:56 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:54:56 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 16:54:56 volumio volumio[9401]: info: ControllerMpd::pushState May 04 16:54:56 volumio volumio[9401]: info: CoreCommandRouter::servicePushState May 04 16:54:56 volumio volumio[9401]: info: CorePlayQueue::getTrack 0 May 04 16:54:56 volumio volumio[9401]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846730,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grover Washington Jr. - In The Name Of Love","artist":"/SwissJazz_Room1","album":null,"uri":"https://stream.srg-ssr.ch/m/rsj/mp3_128","trackType":""} May 04 16:54:56 volumio volumio[9401]: verbose: CURRENT POSITION 0 May 04 16:54:56 volumio volumio[9401]: info: CoreStateMachine::syncState stateService play May 04 16:54:56 volumio volumio[9401]: info: CoreStateMachine::syncState currentStatus play May 04 16:54:56 volumio volumio[9401]: info: Received an update from plugin. extracting info from payload May 04 16:54:56 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:54:56 volumio volumio[9401]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 04 16:54:56 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:54:56 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:54:56 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:54:56 volumio volumio[9401]: info: ------------------------------ 336ms May 04 16:54:56 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:54:56 volumio volumio[9401]: info: May 04 16:54:56 volumio volumio[9401]: ---------------------------- MPD announces state update: update May 04 16:54:56 volumio volumio[9401]: info: ControllerMpd::getState May 04 16:54:56 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:54:56 volumio volumio[9401]: info: sendMpdCommand playlistinfo took 72 milliseconds May 04 16:54:56 volumio volumio[9401]: info: sendMpdCommand playlistinfo took 57 milliseconds May 04 16:54:56 volumio volumio[9401]: info: sendMpdCommand playlistinfo took 43 milliseconds May 04 16:54:56 volumio volumio[9401]: info: sendMpdCommand playlistinfo took 25 milliseconds May 04 16:54:56 volumio volumio[9401]: info: sendMpdCommand status took 4 milliseconds May 04 16:54:56 volumio volumio[9401]: info: sendMpdCommand status took 3 milliseconds May 04 16:54:56 volumio volumio[9401]: verbose: ControllerMpd::parseTrackInfo May 04 16:54:56 volumio volumio[9401]: verbose: ControllerMpd::parseTrackInfo May 04 16:54:56 volumio volumio[9401]: verbose: ControllerMpd::parseTrackInfo May 04 16:54:56 volumio volumio[9401]: verbose: ControllerMpd::parseTrackInfo May 04 16:54:56 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:54:56 volumio volumio[9401]: info: Command Router : Notfying DB Updatefalse May 04 16:54:56 volumio volumio[9401]: info: CoreCommandRouter::Close All Modals sent May 04 16:54:56 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:54:56 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 16:54:56 volumio volumio[9401]: info: ControllerMpd::pushState May 04 16:54:56 volumio volumio[9401]: info: CoreCommandRouter::servicePushState May 04 16:54:56 volumio volumio[9401]: info: CorePlayQueue::getTrack 0 May 04 16:54:56 volumio volumio[9401]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846730,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grover Washington Jr. - In The Name Of Love","artist":"/SwissJazz_Room1","album":null,"uri":"https://stream.srg-ssr.ch/m/rsj/mp3_128","trackType":""} May 04 16:54:56 volumio volumio[9401]: verbose: CURRENT POSITION 0 May 04 16:54:56 volumio volumio[9401]: info: CoreStateMachine::syncState stateService play May 04 16:54:56 volumio volumio[9401]: info: CoreStateMachine::syncState currentStatus play May 04 16:54:56 volumio volumio[9401]: info: Received an update from plugin. extracting info from payload May 04 16:54:56 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:54:56 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:54:56 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:54:56 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:54:56 volumio volumio[9401]: info: ControllerMpd::pushState May 04 16:54:56 volumio volumio[9401]: info: CoreCommandRouter::servicePushState May 04 16:54:56 volumio volumio[9401]: info: CorePlayQueue::getTrack 0 May 04 16:54:56 volumio volumio[9401]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846730,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grover Washington Jr. - In The Name Of Love","artist":"/SwissJazz_Room1","album":null,"uri":"https://stream.srg-ssr.ch/m/rsj/mp3_128","trackType":""} May 04 16:54:56 volumio volumio[9401]: verbose: CURRENT POSITION 0 May 04 16:54:56 volumio volumio[9401]: info: CoreStateMachine::syncState stateService play May 04 16:54:56 volumio volumio[9401]: info: CoreStateMachine::syncState currentStatus play May 04 16:54:56 volumio volumio[9401]: info: Received an update from plugin. extracting info from payload May 04 16:54:56 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:54:56 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:54:56 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:54:56 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:54:56 volumio volumio[9401]: info: ControllerMpd::pushState May 04 16:54:56 volumio volumio[9401]: info: CoreCommandRouter::servicePushState May 04 16:54:56 volumio volumio[9401]: info: CorePlayQueue::getTrack 0 May 04 16:54:56 volumio volumio[9401]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846730,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grover Washington Jr. - In The Name Of Love","artist":"/SwissJazz_Room1","album":null,"uri":"https://stream.srg-ssr.ch/m/rsj/mp3_128","trackType":""} May 04 16:54:56 volumio volumio[9401]: verbose: CURRENT POSITION 0 May 04 16:54:56 volumio volumio[9401]: info: CoreStateMachine::syncState stateService play May 04 16:54:56 volumio volumio[9401]: info: CoreStateMachine::syncState currentStatus play May 04 16:54:56 volumio volumio[9401]: info: Received an update from plugin. extracting info from payload May 04 16:54:56 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:54:56 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:54:56 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:54:56 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:54:56 volumio volumio[9401]: info: ControllerMpd::pushState May 04 16:54:56 volumio volumio[9401]: info: CoreCommandRouter::servicePushState May 04 16:54:56 volumio volumio[9401]: info: CorePlayQueue::getTrack 0 May 04 16:54:56 volumio volumio[9401]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846981,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grover Washington Jr. - In The Name Of Love","artist":"/SwissJazz_Room1","album":null,"uri":"https://stream.srg-ssr.ch/m/rsj/mp3_128","trackType":""} May 04 16:54:56 volumio volumio[9401]: verbose: CURRENT POSITION 0 May 04 16:54:56 volumio volumio[9401]: info: CoreStateMachine::syncState stateService play May 04 16:54:56 volumio volumio[9401]: info: CoreStateMachine::syncState currentStatus play May 04 16:54:56 volumio volumio[9401]: info: Received an update from plugin. extracting info from payload May 04 16:54:56 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:54:56 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:54:56 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:54:56 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:54:56 volumio volumio[9401]: info: ------------------------------ 392ms May 04 16:54:56 volumio volumio[9401]: info: ------------------------------ 391ms May 04 16:54:56 volumio volumio[9401]: info: ------------------------------ 391ms May 04 16:54:56 volumio volumio[9401]: info: ------------------------------ 206ms May 04 16:54:56 volumio volumio[9401]: info: sendMpdCommand playlistinfo took 37 milliseconds May 04 16:54:56 volumio volumio[9401]: verbose: ControllerMpd::parseTrackInfo May 04 16:54:56 volumio volumio[9401]: info: ControllerMpd::pushState May 04 16:54:56 volumio volumio[9401]: info: CoreCommandRouter::servicePushState May 04 16:54:56 volumio volumio[9401]: info: CorePlayQueue::getTrack 0 May 04 16:54:56 volumio volumio[9401]: verbose: STATE SERVICE {"status":"play","position":0,"seek":847106,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grover Washington Jr. - In The Name Of Love","artist":"/SwissJazz_Room1","album":null,"uri":"https://stream.srg-ssr.ch/m/rsj/mp3_128","trackType":""} May 04 16:54:56 volumio volumio[9401]: verbose: CURRENT POSITION 0 May 04 16:54:56 volumio volumio[9401]: info: CoreStateMachine::syncState stateService play May 04 16:54:56 volumio volumio[9401]: info: CoreStateMachine::syncState currentStatus play May 04 16:54:56 volumio volumio[9401]: info: Received an update from plugin. extracting info from payload May 04 16:54:56 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:54:56 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:54:56 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:54:56 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:54:56 volumio volumio[9401]: info: ------------------------------ 66ms May 04 16:54:56 volumio kernel: intel ips 0000:00:1f.6: failed to disable graphics turbo May 04 16:54:57 volumio volumio[9401]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 04 16:54:58 volumio volumio[9401]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb May 04 16:54:58 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand update May 04 16:54:58 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:54:58 volumio volumio[9401]: info: May 04 16:54:58 volumio volumio[9401]: ---------------------------- MPD announces state update: update May 04 16:54:58 volumio volumio[9401]: info: sendMpdCommand update took 1 milliseconds May 04 16:54:58 volumio volumio[9401]: info: ControllerMpd::getState May 04 16:54:58 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:54:58 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:54:58 volumio volumio[9401]: info: May 04 16:54:58 volumio volumio[9401]: ---------------------------- MPD announces state update: update May 04 16:54:58 volumio volumio[9401]: info: ControllerMpd::getState May 04 16:54:58 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:54:58 volumio volumio[9401]: info: sendMpdCommand status took 2 milliseconds May 04 16:54:58 volumio volumio[9401]: info: sendMpdCommand status took 1 milliseconds May 04 16:54:58 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:54:58 volumio volumio[9401]: info: Command Router : Notfying DB Updatefalse May 04 16:54:58 volumio volumio[9401]: info: CoreCommandRouter::Close All Modals sent May 04 16:54:58 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:54:58 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 16:54:58 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:54:58 volumio volumio[9401]: info: May 04 16:54:58 volumio volumio[9401]: ---------------------------- MPD announces state update: update May 04 16:54:58 volumio volumio[9401]: info: ControllerMpd::getState May 04 16:54:58 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:54:58 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:54:58 volumio volumio[9401]: info: May 04 16:54:58 volumio volumio[9401]: ---------------------------- MPD announces state update: update May 04 16:54:58 volumio volumio[9401]: info: ControllerMpd::getState May 04 16:54:58 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:54:58 volumio volumio[9401]: info: sendMpdCommand status took 105 milliseconds May 04 16:54:58 volumio volumio[9401]: info: sendMpdCommand status took 104 milliseconds May 04 16:54:58 volumio volumio[9401]: info: sendMpdCommand playlistinfo took 6 milliseconds May 04 16:54:58 volumio volumio[9401]: info: sendMpdCommand status took 3 milliseconds May 04 16:54:58 volumio volumio[9401]: info: sendMpdCommand status took 3 milliseconds May 04 16:54:58 volumio volumio[9401]: info: sendMpdCommand status took 2 milliseconds May 04 16:54:58 volumio volumio[9401]: info: sendMpdCommand status took 1 milliseconds May 04 16:54:58 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:54:58 volumio volumio[9401]: info: Command Router : Notfying DB Updatefalse May 04 16:54:58 volumio volumio[9401]: info: CoreCommandRouter::Close All Modals sent May 04 16:54:58 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:54:58 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 16:54:58 volumio volumio[9401]: verbose: ControllerMpd::parseTrackInfo May 04 16:54:58 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:54:58 volumio volumio[9401]: info: Command Router : Notfying DB Updatefalse May 04 16:54:58 volumio volumio[9401]: info: CoreCommandRouter::Close All Modals sent May 04 16:54:58 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:54:58 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 16:54:58 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:54:58 volumio volumio[9401]: info: Command Router : Notfying DB Updatefalse May 04 16:54:58 volumio volumio[9401]: info: CoreCommandRouter::Close All Modals sent May 04 16:54:58 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:54:58 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 16:54:58 volumio volumio[9401]: info: ControllerMpd::pushState May 04 16:54:58 volumio volumio[9401]: info: CoreCommandRouter::servicePushState May 04 16:54:58 volumio volumio[9401]: info: CorePlayQueue::getTrack 0 May 04 16:54:58 volumio volumio[9401]: verbose: STATE SERVICE {"status":"play","position":0,"seek":848612,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grover Washington Jr. - In The Name Of Love","artist":"/SwissJazz_Room1","album":null,"uri":"https://stream.srg-ssr.ch/m/rsj/mp3_128","trackType":""} May 04 16:54:58 volumio volumio[9401]: verbose: CURRENT POSITION 0 May 04 16:54:58 volumio volumio[9401]: info: CoreStateMachine::syncState stateService play May 04 16:54:58 volumio volumio[9401]: info: CoreStateMachine::syncState currentStatus play May 04 16:54:58 volumio volumio[9401]: info: Received an update from plugin. extracting info from payload May 04 16:54:58 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:54:58 volumio volumio[9401]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 04 16:54:58 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:54:58 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:54:58 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:54:58 volumio volumio[9401]: info: ------------------------------ 244ms May 04 16:54:58 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:54:58 volumio volumio[9401]: info: May 04 16:54:58 volumio volumio[9401]: ---------------------------- MPD announces state update: update May 04 16:54:58 volumio volumio[9401]: info: ControllerMpd::getState May 04 16:54:58 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:54:58 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:54:58 volumio volumio[9401]: info: May 04 16:54:58 volumio volumio[9401]: ---------------------------- MPD announces state update: update May 04 16:54:58 volumio volumio[9401]: info: ControllerMpd::getState May 04 16:54:58 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:54:58 volumio volumio[9401]: info: sendMpdCommand playlistinfo took 62 milliseconds May 04 16:54:58 volumio volumio[9401]: info: sendMpdCommand playlistinfo took 45 milliseconds May 04 16:54:58 volumio volumio[9401]: info: sendMpdCommand playlistinfo took 27 milliseconds May 04 16:54:58 volumio volumio[9401]: info: sendMpdCommand status took 7 milliseconds May 04 16:54:58 volumio volumio[9401]: info: sendMpdCommand status took 6 milliseconds May 04 16:54:58 volumio volumio[9401]: info: sendMpdCommand status took 5 milliseconds May 04 16:54:58 volumio volumio[9401]: info: sendMpdCommand status took 5 milliseconds May 04 16:54:58 volumio volumio[9401]: verbose: ControllerMpd::parseTrackInfo May 04 16:54:58 volumio volumio[9401]: verbose: ControllerMpd::parseTrackInfo May 04 16:54:58 volumio volumio[9401]: verbose: ControllerMpd::parseTrackInfo May 04 16:54:58 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:54:58 volumio volumio[9401]: info: Command Router : Notfying DB Updatefalse May 04 16:54:58 volumio volumio[9401]: info: CoreCommandRouter::Close All Modals sent May 04 16:54:58 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:54:58 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 16:54:58 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:54:58 volumio volumio[9401]: info: Command Router : Notfying DB Updatefalse May 04 16:54:58 volumio volumio[9401]: info: CoreCommandRouter::Close All Modals sent May 04 16:54:58 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:54:58 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 16:54:58 volumio volumio[9401]: info: ControllerMpd::pushState May 04 16:54:58 volumio volumio[9401]: info: CoreCommandRouter::servicePushState May 04 16:54:58 volumio volumio[9401]: info: CorePlayQueue::getTrack 0 May 04 16:54:58 volumio volumio[9401]: verbose: STATE SERVICE {"status":"play","position":0,"seek":848612,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grover Washington Jr. - In The Name Of Love","artist":"/SwissJazz_Room1","album":null,"uri":"https://stream.srg-ssr.ch/m/rsj/mp3_128","trackType":""} May 04 16:54:58 volumio volumio[9401]: verbose: CURRENT POSITION 0 May 04 16:54:58 volumio volumio[9401]: info: CoreStateMachine::syncState stateService play May 04 16:54:58 volumio volumio[9401]: info: CoreStateMachine::syncState currentStatus play May 04 16:54:58 volumio volumio[9401]: info: Received an update from plugin. extracting info from payload May 04 16:54:58 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:54:58 volumio volumio[9401]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 04 16:54:58 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:54:58 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:54:58 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:54:58 volumio volumio[9401]: info: ControllerMpd::pushState May 04 16:54:58 volumio volumio[9401]: info: CoreCommandRouter::servicePushState May 04 16:54:58 volumio volumio[9401]: info: CorePlayQueue::getTrack 0 May 04 16:54:58 volumio volumio[9401]: verbose: STATE SERVICE {"status":"play","position":0,"seek":848612,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grover Washington Jr. - In The Name Of Love","artist":"/SwissJazz_Room1","album":null,"uri":"https://stream.srg-ssr.ch/m/rsj/mp3_128","trackType":""} May 04 16:54:58 volumio volumio[9401]: verbose: CURRENT POSITION 0 May 04 16:54:58 volumio volumio[9401]: info: CoreStateMachine::syncState stateService play May 04 16:54:58 volumio volumio[9401]: info: CoreStateMachine::syncState currentStatus play May 04 16:54:58 volumio volumio[9401]: info: Received an update from plugin. extracting info from payload May 04 16:54:58 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:54:58 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:54:58 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:54:58 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:54:58 volumio volumio[9401]: info: ControllerMpd::pushState May 04 16:54:58 volumio volumio[9401]: info: CoreCommandRouter::servicePushState May 04 16:54:58 volumio volumio[9401]: info: CorePlayQueue::getTrack 0 May 04 16:54:58 volumio volumio[9401]: verbose: STATE SERVICE {"status":"play","position":0,"seek":848612,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grover Washington Jr. - In The Name Of Love","artist":"/SwissJazz_Room1","album":null,"uri":"https://stream.srg-ssr.ch/m/rsj/mp3_128","trackType":""} May 04 16:54:58 volumio volumio[9401]: verbose: CURRENT POSITION 0 May 04 16:54:58 volumio volumio[9401]: info: CoreStateMachine::syncState stateService play May 04 16:54:58 volumio volumio[9401]: info: CoreStateMachine::syncState currentStatus play May 04 16:54:58 volumio volumio[9401]: info: Received an update from plugin. extracting info from payload May 04 16:54:58 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:54:58 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:54:58 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:54:58 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:54:58 volumio volumio[9401]: info: ------------------------------ 315ms May 04 16:54:58 volumio volumio[9401]: info: ------------------------------ 212ms May 04 16:54:58 volumio volumio[9401]: info: ------------------------------ 211ms May 04 16:54:58 volumio volumio[9401]: info: sendMpdCommand playlistinfo took 50 milliseconds May 04 16:54:58 volumio volumio[9401]: info: sendMpdCommand playlistinfo took 38 milliseconds May 04 16:54:58 volumio volumio[9401]: verbose: ControllerMpd::parseTrackInfo May 04 16:54:58 volumio volumio[9401]: verbose: ControllerMpd::parseTrackInfo May 04 16:54:58 volumio volumio[9401]: info: ControllerMpd::pushState May 04 16:54:58 volumio volumio[9401]: info: CoreCommandRouter::servicePushState May 04 16:54:58 volumio volumio[9401]: info: CorePlayQueue::getTrack 0 May 04 16:54:58 volumio volumio[9401]: verbose: STATE SERVICE {"status":"play","position":0,"seek":848863,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grover Washington Jr. - In The Name Of Love","artist":"/SwissJazz_Room1","album":null,"uri":"https://stream.srg-ssr.ch/m/rsj/mp3_128","trackType":""} May 04 16:54:58 volumio volumio[9401]: verbose: CURRENT POSITION 0 May 04 16:54:58 volumio volumio[9401]: info: CoreStateMachine::syncState stateService play May 04 16:54:58 volumio volumio[9401]: info: CoreStateMachine::syncState currentStatus play May 04 16:54:58 volumio volumio[9401]: info: Received an update from plugin. extracting info from payload May 04 16:54:58 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:54:58 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:54:58 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:54:58 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:54:58 volumio volumio[9401]: info: ControllerMpd::pushState May 04 16:54:58 volumio volumio[9401]: info: CoreCommandRouter::servicePushState May 04 16:54:58 volumio volumio[9401]: info: CorePlayQueue::getTrack 0 May 04 16:54:58 volumio volumio[9401]: verbose: STATE SERVICE {"status":"play","position":0,"seek":848863,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grover Washington Jr. - In The Name Of Love","artist":"/SwissJazz_Room1","album":null,"uri":"https://stream.srg-ssr.ch/m/rsj/mp3_128","trackType":""} May 04 16:54:58 volumio volumio[9401]: verbose: CURRENT POSITION 0 May 04 16:54:58 volumio volumio[9401]: info: CoreStateMachine::syncState stateService play May 04 16:54:58 volumio volumio[9401]: info: CoreStateMachine::syncState currentStatus play May 04 16:54:58 volumio volumio[9401]: info: Received an update from plugin. extracting info from payload May 04 16:54:58 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:54:58 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:54:58 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:54:58 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:54:58 volumio volumio[9401]: info: ------------------------------ 92ms May 04 16:54:58 volumio volumio[9401]: info: ------------------------------ 91ms May 04 16:54:59 volumio volumio[9401]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb May 04 16:54:59 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand update May 04 16:54:59 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:54:59 volumio volumio[9401]: info: May 04 16:54:59 volumio volumio[9401]: ---------------------------- MPD announces state update: update May 04 16:54:59 volumio volumio[9401]: info: sendMpdCommand update took 2 milliseconds May 04 16:54:59 volumio volumio[9401]: info: ControllerMpd::getState May 04 16:54:59 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:54:59 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:54:59 volumio volumio[9401]: info: May 04 16:54:59 volumio volumio[9401]: ---------------------------- MPD announces state update: update May 04 16:54:59 volumio volumio[9401]: info: ControllerMpd::getState May 04 16:54:59 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:54:59 volumio volumio[9401]: info: sendMpdCommand status took 1 milliseconds May 04 16:54:59 volumio volumio[9401]: info: sendMpdCommand status took 1 milliseconds May 04 16:54:59 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:54:59 volumio volumio[9401]: info: Command Router : Notfying DB Updatefalse May 04 16:54:59 volumio volumio[9401]: info: CoreCommandRouter::Close All Modals sent May 04 16:54:59 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:54:59 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 16:54:59 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:54:59 volumio volumio[9401]: info: May 04 16:54:59 volumio volumio[9401]: ---------------------------- MPD announces state update: update May 04 16:54:59 volumio volumio[9401]: info: ControllerMpd::getState May 04 16:54:59 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:54:59 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:54:59 volumio volumio[9401]: info: May 04 16:54:59 volumio volumio[9401]: ---------------------------- MPD announces state update: update May 04 16:54:59 volumio volumio[9401]: info: ControllerMpd::getState May 04 16:54:59 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:54:59 volumio volumio[9401]: info: sendMpdCommand status took 119 milliseconds May 04 16:54:59 volumio volumio[9401]: info: sendMpdCommand status took 119 milliseconds May 04 16:54:59 volumio volumio[9401]: info: sendMpdCommand playlistinfo took 4 milliseconds May 04 16:54:59 volumio volumio[9401]: info: sendMpdCommand status took 2 milliseconds May 04 16:54:59 volumio volumio[9401]: info: sendMpdCommand status took 1 milliseconds May 04 16:54:59 volumio volumio[9401]: info: sendMpdCommand status took 2 milliseconds May 04 16:54:59 volumio volumio[9401]: info: sendMpdCommand status took 2 milliseconds May 04 16:54:59 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:54:59 volumio volumio[9401]: info: Command Router : Notfying DB Updatefalse May 04 16:54:59 volumio volumio[9401]: info: CoreCommandRouter::Close All Modals sent May 04 16:54:59 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:54:59 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 16:54:59 volumio volumio[9401]: verbose: ControllerMpd::parseTrackInfo May 04 16:54:59 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:54:59 volumio volumio[9401]: info: Command Router : Notfying DB Updatefalse May 04 16:54:59 volumio volumio[9401]: info: CoreCommandRouter::Close All Modals sent May 04 16:54:59 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:54:59 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 16:54:59 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:54:59 volumio volumio[9401]: info: Command Router : Notfying DB Updatefalse May 04 16:54:59 volumio volumio[9401]: info: CoreCommandRouter::Close All Modals sent May 04 16:54:59 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:54:59 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 16:54:59 volumio volumio[9401]: info: ControllerMpd::pushState May 04 16:54:59 volumio volumio[9401]: info: CoreCommandRouter::servicePushState May 04 16:54:59 volumio volumio[9401]: info: CorePlayQueue::getTrack 0 May 04 16:54:59 volumio volumio[9401]: verbose: STATE SERVICE {"status":"play","position":0,"seek":849857,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grover Washington Jr. - In The Name Of Love","artist":"/SwissJazz_Room1","album":null,"uri":"https://stream.srg-ssr.ch/m/rsj/mp3_128","trackType":""} May 04 16:54:59 volumio volumio[9401]: verbose: CURRENT POSITION 0 May 04 16:54:59 volumio volumio[9401]: info: CoreStateMachine::syncState stateService play May 04 16:54:59 volumio volumio[9401]: info: CoreStateMachine::syncState currentStatus play May 04 16:54:59 volumio volumio[9401]: info: Received an update from plugin. extracting info from payload May 04 16:54:59 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:54:59 volumio volumio[9401]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 04 16:54:59 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:54:59 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:54:59 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:54:59 volumio volumio[9401]: info: ------------------------------ 323ms May 04 16:54:59 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:54:59 volumio volumio[9401]: info: May 04 16:54:59 volumio volumio[9401]: ---------------------------- MPD announces state update: update May 04 16:54:59 volumio volumio[9401]: info: ControllerMpd::getState May 04 16:54:59 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:54:59 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:54:59 volumio volumio[9401]: info: May 04 16:54:59 volumio volumio[9401]: ---------------------------- MPD announces state update: update May 04 16:54:59 volumio volumio[9401]: info: ControllerMpd::getState May 04 16:54:59 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:54:59 volumio volumio[9401]: info: sendMpdCommand playlistinfo took 79 milliseconds May 04 16:54:59 volumio volumio[9401]: info: sendMpdCommand playlistinfo took 46 milliseconds May 04 16:54:59 volumio volumio[9401]: info: sendMpdCommand playlistinfo took 29 milliseconds May 04 16:54:59 volumio volumio[9401]: info: sendMpdCommand status took 7 milliseconds May 04 16:54:59 volumio volumio[9401]: info: sendMpdCommand status took 7 milliseconds May 04 16:54:59 volumio volumio[9401]: info: sendMpdCommand status took 6 milliseconds May 04 16:54:59 volumio volumio[9401]: info: sendMpdCommand status took 5 milliseconds May 04 16:54:59 volumio volumio[9401]: verbose: ControllerMpd::parseTrackInfo May 04 16:54:59 volumio volumio[9401]: verbose: ControllerMpd::parseTrackInfo May 04 16:54:59 volumio volumio[9401]: verbose: ControllerMpd::parseTrackInfo May 04 16:54:59 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:54:59 volumio volumio[9401]: info: Command Router : Notfying DB Updatefalse May 04 16:54:59 volumio volumio[9401]: info: CoreCommandRouter::Close All Modals sent May 04 16:54:59 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:54:59 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 16:54:59 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:54:59 volumio volumio[9401]: info: Command Router : Notfying DB Updatefalse May 04 16:54:59 volumio volumio[9401]: info: CoreCommandRouter::Close All Modals sent May 04 16:54:59 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:54:59 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 16:54:59 volumio volumio[9401]: info: ControllerMpd::pushState May 04 16:54:59 volumio volumio[9401]: info: CoreCommandRouter::servicePushState May 04 16:54:59 volumio volumio[9401]: info: CorePlayQueue::getTrack 0 May 04 16:54:59 volumio volumio[9401]: verbose: STATE SERVICE {"status":"play","position":0,"seek":849857,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grover Washington Jr. - In The Name Of Love","artist":"/SwissJazz_Room1","album":null,"uri":"https://stream.srg-ssr.ch/m/rsj/mp3_128","trackType":""} May 04 16:54:59 volumio volumio[9401]: verbose: CURRENT POSITION 0 May 04 16:54:59 volumio volumio[9401]: info: CoreStateMachine::syncState stateService play May 04 16:54:59 volumio volumio[9401]: info: CoreStateMachine::syncState currentStatus play May 04 16:54:59 volumio volumio[9401]: info: Received an update from plugin. extracting info from payload May 04 16:54:59 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:54:59 volumio volumio[9401]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 04 16:54:59 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:54:59 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:54:59 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:54:59 volumio volumio[9401]: info: ControllerMpd::pushState May 04 16:54:59 volumio volumio[9401]: info: CoreCommandRouter::servicePushState May 04 16:54:59 volumio volumio[9401]: info: CorePlayQueue::getTrack 0 May 04 16:54:59 volumio volumio[9401]: verbose: STATE SERVICE {"status":"play","position":0,"seek":849982,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grover Washington Jr. - In The Name Of Love","artist":"/SwissJazz_Room1","album":null,"uri":"https://stream.srg-ssr.ch/m/rsj/mp3_128","trackType":""} May 04 16:54:59 volumio volumio[9401]: verbose: CURRENT POSITION 0 May 04 16:54:59 volumio volumio[9401]: info: CoreStateMachine::syncState stateService play May 04 16:54:59 volumio volumio[9401]: info: CoreStateMachine::syncState currentStatus play May 04 16:54:59 volumio volumio[9401]: info: Received an update from plugin. extracting info from payload May 04 16:54:59 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:54:59 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:54:59 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:54:59 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:54:59 volumio volumio[9401]: info: ControllerMpd::pushState May 04 16:54:59 volumio volumio[9401]: info: CoreCommandRouter::servicePushState May 04 16:54:59 volumio volumio[9401]: info: CorePlayQueue::getTrack 0 May 04 16:54:59 volumio volumio[9401]: verbose: STATE SERVICE {"status":"play","position":0,"seek":849982,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grover Washington Jr. - In The Name Of Love","artist":"/SwissJazz_Room1","album":null,"uri":"https://stream.srg-ssr.ch/m/rsj/mp3_128","trackType":""} May 04 16:54:59 volumio volumio[9401]: verbose: CURRENT POSITION 0 May 04 16:54:59 volumio volumio[9401]: info: CoreStateMachine::syncState stateService play May 04 16:54:59 volumio volumio[9401]: info: CoreStateMachine::syncState currentStatus play May 04 16:54:59 volumio volumio[9401]: info: Received an update from plugin. extracting info from payload May 04 16:54:59 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:54:59 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:54:59 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:54:59 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:54:59 volumio volumio[9401]: info: ------------------------------ 390ms May 04 16:54:59 volumio volumio[9401]: info: ------------------------------ 275ms May 04 16:54:59 volumio volumio[9401]: info: ------------------------------ 275ms May 04 16:54:59 volumio volumio[9401]: info: sendMpdCommand playlistinfo took 47 milliseconds May 04 16:54:59 volumio volumio[9401]: info: sendMpdCommand playlistinfo took 34 milliseconds May 04 16:54:59 volumio volumio[9401]: verbose: ControllerMpd::parseTrackInfo May 04 16:54:59 volumio volumio[9401]: verbose: ControllerMpd::parseTrackInfo May 04 16:54:59 volumio volumio[9401]: info: ControllerMpd::pushState May 04 16:54:59 volumio volumio[9401]: info: CoreCommandRouter::servicePushState May 04 16:54:59 volumio volumio[9401]: info: CorePlayQueue::getTrack 0 May 04 16:54:59 volumio volumio[9401]: verbose: STATE SERVICE {"status":"play","position":0,"seek":850233,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grover Washington Jr. - In The Name Of Love","artist":"/SwissJazz_Room1","album":null,"uri":"https://stream.srg-ssr.ch/m/rsj/mp3_128","trackType":""} May 04 16:54:59 volumio volumio[9401]: verbose: CURRENT POSITION 0 May 04 16:54:59 volumio volumio[9401]: info: CoreStateMachine::syncState stateService play May 04 16:54:59 volumio volumio[9401]: info: CoreStateMachine::syncState currentStatus play May 04 16:54:59 volumio volumio[9401]: info: Received an update from plugin. extracting info from payload May 04 16:54:59 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:54:59 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:54:59 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:54:59 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:54:59 volumio volumio[9401]: info: ControllerMpd::pushState May 04 16:54:59 volumio volumio[9401]: info: CoreCommandRouter::servicePushState May 04 16:54:59 volumio volumio[9401]: info: CorePlayQueue::getTrack 0 May 04 16:54:59 volumio volumio[9401]: verbose: STATE SERVICE {"status":"play","position":0,"seek":850233,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grover Washington Jr. - In The Name Of Love","artist":"/SwissJazz_Room1","album":null,"uri":"https://stream.srg-ssr.ch/m/rsj/mp3_128","trackType":""} May 04 16:54:59 volumio volumio[9401]: verbose: CURRENT POSITION 0 May 04 16:54:59 volumio volumio[9401]: info: CoreStateMachine::syncState stateService play May 04 16:54:59 volumio volumio[9401]: info: CoreStateMachine::syncState currentStatus play May 04 16:54:59 volumio volumio[9401]: info: Received an update from plugin. extracting info from payload May 04 16:54:59 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:54:59 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:54:59 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:54:59 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:54:59 volumio volumio[9401]: info: ------------------------------ 86ms May 04 16:54:59 volumio volumio[9401]: info: ------------------------------ 85ms May 04 16:54:59 volumio volumio[9401]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb May 04 16:54:59 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand update May 04 16:54:59 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:54:59 volumio volumio[9401]: info: May 04 16:54:59 volumio volumio[9401]: ---------------------------- MPD announces state update: update May 04 16:54:59 volumio volumio[9401]: info: sendMpdCommand update took 1 milliseconds May 04 16:54:59 volumio volumio[9401]: info: ControllerMpd::getState May 04 16:54:59 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:54:59 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:54:59 volumio volumio[9401]: info: May 04 16:54:59 volumio volumio[9401]: ---------------------------- MPD announces state update: update May 04 16:54:59 volumio volumio[9401]: info: ControllerMpd::getState May 04 16:54:59 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:54:59 volumio volumio[9401]: info: sendMpdCommand status took 1 milliseconds May 04 16:54:59 volumio volumio[9401]: info: sendMpdCommand status took 1 milliseconds May 04 16:54:59 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:00 volumio volumio[9401]: info: Command Router : Notfying DB Updatefalse May 04 16:55:00 volumio volumio[9401]: info: CoreCommandRouter::Close All Modals sent May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:00 volumio volumio[9401]: info: May 04 16:55:00 volumio volumio[9401]: ---------------------------- MPD announces state update: update May 04 16:55:00 volumio volumio[9401]: info: ControllerMpd::getState May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:00 volumio volumio[9401]: info: May 04 16:55:00 volumio volumio[9401]: ---------------------------- MPD announces state update: update May 04 16:55:00 volumio volumio[9401]: info: ControllerMpd::getState May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:00 volumio volumio[9401]: info: sendMpdCommand status took 99 milliseconds May 04 16:55:00 volumio volumio[9401]: info: sendMpdCommand status took 100 milliseconds May 04 16:55:00 volumio volumio[9401]: info: sendMpdCommand playlistinfo took 6 milliseconds May 04 16:55:00 volumio volumio[9401]: info: sendMpdCommand status took 3 milliseconds May 04 16:55:00 volumio volumio[9401]: info: sendMpdCommand status took 2 milliseconds May 04 16:55:00 volumio volumio[9401]: info: sendMpdCommand status took 2 milliseconds May 04 16:55:00 volumio volumio[9401]: info: sendMpdCommand status took 1 milliseconds May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:00 volumio volumio[9401]: info: Command Router : Notfying DB Updatefalse May 04 16:55:00 volumio volumio[9401]: info: CoreCommandRouter::Close All Modals sent May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::parseTrackInfo May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:00 volumio volumio[9401]: info: Command Router : Notfying DB Updatefalse May 04 16:55:00 volumio volumio[9401]: info: CoreCommandRouter::Close All Modals sent May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:00 volumio volumio[9401]: info: Command Router : Notfying DB Updatefalse May 04 16:55:00 volumio volumio[9401]: info: CoreCommandRouter::Close All Modals sent May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 16:55:00 volumio volumio[9401]: info: ControllerMpd::pushState May 04 16:55:00 volumio volumio[9401]: info: CoreCommandRouter::servicePushState May 04 16:55:00 volumio volumio[9401]: info: CorePlayQueue::getTrack 0 May 04 16:55:00 volumio volumio[9401]: verbose: STATE SERVICE {"status":"play","position":0,"seek":850484,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grover Washington Jr. - In The Name Of Love","artist":"/SwissJazz_Room1","album":null,"uri":"https://stream.srg-ssr.ch/m/rsj/mp3_128","trackType":""} May 04 16:55:00 volumio volumio[9401]: verbose: CURRENT POSITION 0 May 04 16:55:00 volumio volumio[9401]: info: CoreStateMachine::syncState stateService play May 04 16:55:00 volumio volumio[9401]: info: CoreStateMachine::syncState currentStatus play May 04 16:55:00 volumio volumio[9401]: info: Received an update from plugin. extracting info from payload May 04 16:55:00 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:00 volumio volumio[9401]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 04 16:55:00 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:00 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:00 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:00 volumio volumio[9401]: info: ------------------------------ 293ms May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:00 volumio volumio[9401]: info: May 04 16:55:00 volumio volumio[9401]: ---------------------------- MPD announces state update: update May 04 16:55:00 volumio volumio[9401]: info: ControllerMpd::getState May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:00 volumio volumio[9401]: info: May 04 16:55:00 volumio volumio[9401]: ---------------------------- MPD announces state update: update May 04 16:55:00 volumio volumio[9401]: info: ControllerMpd::getState May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:00 volumio volumio[9401]: info: sendMpdCommand playlistinfo took 126 milliseconds May 04 16:55:00 volumio volumio[9401]: info: sendMpdCommand playlistinfo took 81 milliseconds May 04 16:55:00 volumio volumio[9401]: info: sendMpdCommand playlistinfo took 19 milliseconds May 04 16:55:00 volumio volumio[9401]: info: sendMpdCommand status took 5 milliseconds May 04 16:55:00 volumio volumio[9401]: info: sendMpdCommand status took 4 milliseconds May 04 16:55:00 volumio volumio[9401]: info: sendMpdCommand status took 4 milliseconds May 04 16:55:00 volumio volumio[9401]: info: sendMpdCommand status took 3 milliseconds May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::parseTrackInfo May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::parseTrackInfo May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::parseTrackInfo May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:00 volumio volumio[9401]: info: Command Router : Notfying DB Updatefalse May 04 16:55:00 volumio volumio[9401]: info: CoreCommandRouter::Close All Modals sent May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:00 volumio volumio[9401]: info: Command Router : Notfying DB Updatefalse May 04 16:55:00 volumio volumio[9401]: info: CoreCommandRouter::Close All Modals sent May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 16:55:00 volumio volumio[9401]: info: ControllerMpd::pushState May 04 16:55:00 volumio volumio[9401]: info: CoreCommandRouter::servicePushState May 04 16:55:00 volumio volumio[9401]: info: CorePlayQueue::getTrack 0 May 04 16:55:00 volumio volumio[9401]: verbose: STATE SERVICE {"status":"play","position":0,"seek":850484,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grover Washington Jr. - In The Name Of Love","artist":"/SwissJazz_Room1","album":null,"uri":"https://stream.srg-ssr.ch/m/rsj/mp3_128","trackType":""} May 04 16:55:00 volumio volumio[9401]: verbose: CURRENT POSITION 0 May 04 16:55:00 volumio volumio[9401]: info: CoreStateMachine::syncState stateService play May 04 16:55:00 volumio volumio[9401]: info: CoreStateMachine::syncState currentStatus play May 04 16:55:00 volumio volumio[9401]: info: Received an update from plugin. extracting info from payload May 04 16:55:00 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:00 volumio volumio[9401]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 04 16:55:00 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:00 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:00 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:00 volumio volumio[9401]: info: ControllerMpd::pushState May 04 16:55:00 volumio volumio[9401]: info: CoreCommandRouter::servicePushState May 04 16:55:00 volumio volumio[9401]: info: CorePlayQueue::getTrack 0 May 04 16:55:00 volumio volumio[9401]: verbose: STATE SERVICE {"status":"play","position":0,"seek":850610,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grover Washington Jr. - In The Name Of Love","artist":"/SwissJazz_Room1","album":null,"uri":"https://stream.srg-ssr.ch/m/rsj/mp3_128","trackType":""} May 04 16:55:00 volumio volumio[9401]: verbose: CURRENT POSITION 0 May 04 16:55:00 volumio volumio[9401]: info: CoreStateMachine::syncState stateService play May 04 16:55:00 volumio volumio[9401]: info: CoreStateMachine::syncState currentStatus play May 04 16:55:00 volumio volumio[9401]: info: Received an update from plugin. extracting info from payload May 04 16:55:00 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:00 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:00 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:00 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:00 volumio volumio[9401]: info: ControllerMpd::pushState May 04 16:55:00 volumio volumio[9401]: info: CoreCommandRouter::servicePushState May 04 16:55:00 volumio volumio[9401]: info: CorePlayQueue::getTrack 0 May 04 16:55:00 volumio volumio[9401]: verbose: STATE SERVICE {"status":"play","position":0,"seek":850610,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grover Washington Jr. - In The Name Of Love","artist":"/SwissJazz_Room1","album":null,"uri":"https://stream.srg-ssr.ch/m/rsj/mp3_128","trackType":""} May 04 16:55:00 volumio volumio[9401]: verbose: CURRENT POSITION 0 May 04 16:55:00 volumio volumio[9401]: info: CoreStateMachine::syncState stateService play May 04 16:55:00 volumio volumio[9401]: info: CoreStateMachine::syncState currentStatus play May 04 16:55:00 volumio volumio[9401]: info: Received an update from plugin. extracting info from payload May 04 16:55:00 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:00 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:00 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:00 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:00 volumio volumio[9401]: info: ------------------------------ 358ms May 04 16:55:00 volumio volumio[9401]: info: ------------------------------ 261ms May 04 16:55:00 volumio volumio[9401]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand update May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:00 volumio volumio[9401]: info: May 04 16:55:00 volumio volumio[9401]: ---------------------------- MPD announces state update: update May 04 16:55:00 volumio volumio[9401]: info: sendMpdCommand playlistinfo took 50 milliseconds May 04 16:55:00 volumio volumio[9401]: info: sendMpdCommand playlistinfo took 36 milliseconds May 04 16:55:00 volumio volumio[9401]: info: sendMpdCommand update took 1 milliseconds May 04 16:55:00 volumio volumio[9401]: info: ControllerMpd::getState May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::parseTrackInfo May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::parseTrackInfo May 04 16:55:00 volumio volumio[9401]: info: ControllerMpd::pushState May 04 16:55:00 volumio volumio[9401]: info: CoreCommandRouter::servicePushState May 04 16:55:00 volumio volumio[9401]: info: CorePlayQueue::getTrack 0 May 04 16:55:00 volumio volumio[9401]: verbose: STATE SERVICE {"status":"play","position":0,"seek":850861,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grover Washington Jr. - In The Name Of Love","artist":"/SwissJazz_Room1","album":null,"uri":"https://stream.srg-ssr.ch/m/rsj/mp3_128","trackType":""} May 04 16:55:00 volumio volumio[9401]: verbose: CURRENT POSITION 0 May 04 16:55:00 volumio volumio[9401]: info: CoreStateMachine::syncState stateService play May 04 16:55:00 volumio volumio[9401]: info: CoreStateMachine::syncState currentStatus play May 04 16:55:00 volumio volumio[9401]: info: Received an update from plugin. extracting info from payload May 04 16:55:00 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:00 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:00 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:00 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:00 volumio volumio[9401]: info: ControllerMpd::pushState May 04 16:55:00 volumio volumio[9401]: info: CoreCommandRouter::servicePushState May 04 16:55:00 volumio volumio[9401]: info: CorePlayQueue::getTrack 0 May 04 16:55:00 volumio volumio[9401]: verbose: STATE SERVICE {"status":"play","position":0,"seek":850861,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grover Washington Jr. - In The Name Of Love","artist":"/SwissJazz_Room1","album":null,"uri":"https://stream.srg-ssr.ch/m/rsj/mp3_128","trackType":""} May 04 16:55:00 volumio volumio[9401]: verbose: CURRENT POSITION 0 May 04 16:55:00 volumio volumio[9401]: info: CoreStateMachine::syncState stateService play May 04 16:55:00 volumio volumio[9401]: info: CoreStateMachine::syncState currentStatus play May 04 16:55:00 volumio volumio[9401]: info: Received an update from plugin. extracting info from payload May 04 16:55:00 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:00 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:00 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:00 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:00 volumio volumio[9401]: info: ------------------------------ 92ms May 04 16:55:00 volumio volumio[9401]: info: ------------------------------ 91ms May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:00 volumio volumio[9401]: info: May 04 16:55:00 volumio volumio[9401]: ---------------------------- MPD announces state update: update May 04 16:55:00 volumio volumio[9401]: info: ControllerMpd::getState May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:00 volumio volumio[9401]: info: May 04 16:55:00 volumio volumio[9401]: ---------------------------- MPD announces state update: update May 04 16:55:00 volumio volumio[9401]: info: ControllerMpd::getState May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:00 volumio volumio[9401]: info: May 04 16:55:00 volumio volumio[9401]: ---------------------------- MPD announces state update: update May 04 16:55:00 volumio volumio[9401]: info: sendMpdCommand status took 34 milliseconds May 04 16:55:00 volumio volumio[9401]: info: ControllerMpd::getState May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:00 volumio volumio[9401]: info: sendMpdCommand status took 33 milliseconds May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:00 volumio volumio[9401]: info: Command Router : Notfying DB Updatetrue May 04 16:55:00 volumio volumio[9401]: info: CoreCommandRouter::Close All Modals sent May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:00 volumio volumio[9401]: info: May 04 16:55:00 volumio volumio[9401]: ---------------------------- MPD announces state update: update May 04 16:55:00 volumio volumio[9401]: info: ControllerMpd::getState May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:00 volumio volumio[9401]: info: sendMpdCommand status took 59 milliseconds May 04 16:55:00 volumio volumio[9401]: info: sendMpdCommand status took 60 milliseconds May 04 16:55:00 volumio volumio[9401]: info: sendMpdCommand status took 59 milliseconds May 04 16:55:00 volumio volumio[9401]: info: sendMpdCommand status took 58 milliseconds May 04 16:55:00 volumio volumio[9401]: info: sendMpdCommand status took 57 milliseconds May 04 16:55:00 volumio volumio[9401]: info: sendMpdCommand playlistinfo took 16 milliseconds May 04 16:55:00 volumio volumio[9401]: info: sendMpdCommand status took 13 milliseconds May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:00 volumio volumio[9401]: info: Command Router : Notfying DB Updatefalse May 04 16:55:00 volumio volumio[9401]: info: CoreCommandRouter::Close All Modals sent May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:00 volumio volumio[9401]: info: Command Router : Notfying DB Updatefalse May 04 16:55:00 volumio volumio[9401]: info: CoreCommandRouter::Close All Modals sent May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:00 volumio volumio[9401]: info: Command Router : Notfying DB Updatefalse May 04 16:55:00 volumio volumio[9401]: info: CoreCommandRouter::Close All Modals sent May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::parseTrackInfo May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:00 volumio volumio[9401]: info: Command Router : Notfying DB Updatefalse May 04 16:55:00 volumio volumio[9401]: info: CoreCommandRouter::Close All Modals sent May 04 16:55:00 volumio volumio[9401]: info: ControllerMpd::pushState May 04 16:55:00 volumio volumio[9401]: info: CoreCommandRouter::servicePushState May 04 16:55:00 volumio volumio[9401]: info: CorePlayQueue::getTrack 0 May 04 16:55:00 volumio volumio[9401]: verbose: STATE SERVICE {"status":"play","position":0,"seek":850861,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grover Washington Jr. - In The Name Of Love","artist":"/SwissJazz_Room1","album":null,"uri":"https://stream.srg-ssr.ch/m/rsj/mp3_128","trackType":""} May 04 16:55:00 volumio volumio[9401]: verbose: CURRENT POSITION 0 May 04 16:55:00 volumio volumio[9401]: info: CoreStateMachine::syncState stateService play May 04 16:55:00 volumio volumio[9401]: info: CoreStateMachine::syncState currentStatus play May 04 16:55:00 volumio volumio[9401]: info: Received an update from plugin. extracting info from payload May 04 16:55:00 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:00 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:00 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:00 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:00 volumio volumio[9401]: info: ------------------------------ 256ms May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:00 volumio volumio[9401]: info: May 04 16:55:00 volumio volumio[9401]: ---------------------------- MPD announces state update: update May 04 16:55:00 volumio volumio[9401]: info: ControllerMpd::getState May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:00 volumio volumio[9401]: info: sendMpdCommand status took 178 milliseconds May 04 16:55:00 volumio volumio[9401]: info: sendMpdCommand playlistinfo took 147 milliseconds May 04 16:55:00 volumio volumio[9401]: info: sendMpdCommand playlistinfo took 61 milliseconds May 04 16:55:00 volumio volumio[9401]: info: sendMpdCommand playlistinfo took 47 milliseconds May 04 16:55:00 volumio volumio[9401]: info: sendMpdCommand status took 9 milliseconds May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::parseTrackInfo May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:00 volumio volumio[9401]: info: Command Router : Notfying DB Updatefalse May 04 16:55:00 volumio volumio[9401]: info: CoreCommandRouter::Close All Modals sent May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 16:55:00 volumio volumio[9401]: info: ControllerMpd::pushState May 04 16:55:00 volumio volumio[9401]: info: CoreCommandRouter::servicePushState May 04 16:55:00 volumio volumio[9401]: info: CorePlayQueue::getTrack 0 May 04 16:55:00 volumio volumio[9401]: verbose: STATE SERVICE {"status":"play","position":0,"seek":850861,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grover Washington Jr. - In The Name Of Love","artist":"/SwissJazz_Room1","album":null,"uri":"https://stream.srg-ssr.ch/m/rsj/mp3_128","trackType":""} May 04 16:55:00 volumio volumio[9401]: verbose: CURRENT POSITION 0 May 04 16:55:00 volumio volumio[9401]: info: CoreStateMachine::syncState stateService play May 04 16:55:00 volumio volumio[9401]: info: CoreStateMachine::syncState currentStatus play May 04 16:55:00 volumio volumio[9401]: info: Received an update from plugin. extracting info from payload May 04 16:55:00 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:00 volumio volumio[9401]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 04 16:55:00 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:00 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:00 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:00 volumio volumio[9401]: info: ControllerMpd::pushState May 04 16:55:00 volumio volumio[9401]: info: CoreCommandRouter::servicePushState May 04 16:55:00 volumio volumio[9401]: info: CorePlayQueue::getTrack 0 May 04 16:55:00 volumio volumio[9401]: verbose: STATE SERVICE {"status":"play","position":0,"seek":850861,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grover Washington Jr. - In The Name Of Love","artist":"/SwissJazz_Room1","album":null,"uri":"https://stream.srg-ssr.ch/m/rsj/mp3_128","trackType":""} May 04 16:55:00 volumio volumio[9401]: verbose: CURRENT POSITION 0 May 04 16:55:00 volumio volumio[9401]: info: CoreStateMachine::syncState stateService play May 04 16:55:00 volumio volumio[9401]: info: CoreStateMachine::syncState currentStatus play May 04 16:55:00 volumio volumio[9401]: info: Received an update from plugin. extracting info from payload May 04 16:55:00 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:00 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:00 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:00 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:00 volumio volumio[9401]: info: ControllerMpd::pushState May 04 16:55:00 volumio volumio[9401]: info: CoreCommandRouter::servicePushState May 04 16:55:00 volumio volumio[9401]: info: CorePlayQueue::getTrack 0 May 04 16:55:00 volumio volumio[9401]: verbose: STATE SERVICE {"status":"play","position":0,"seek":850986,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grover Washington Jr. - In The Name Of Love","artist":"/SwissJazz_Room1","album":null,"uri":"https://stream.srg-ssr.ch/m/rsj/mp3_128","trackType":""} May 04 16:55:00 volumio volumio[9401]: verbose: CURRENT POSITION 0 May 04 16:55:00 volumio volumio[9401]: info: CoreStateMachine::syncState stateService play May 04 16:55:00 volumio volumio[9401]: info: CoreStateMachine::syncState currentStatus play May 04 16:55:00 volumio volumio[9401]: info: Received an update from plugin. extracting info from payload May 04 16:55:00 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:00 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:00 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:00 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:00 volumio volumio[9401]: info: ------------------------------ 327ms May 04 16:55:00 volumio volumio[9401]: info: ------------------------------ 326ms May 04 16:55:00 volumio volumio[9401]: info: ------------------------------ 325ms May 04 16:55:00 volumio volumio[9401]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand update May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:00 volumio volumio[9401]: info: May 04 16:55:00 volumio volumio[9401]: ---------------------------- MPD announces state update: update May 04 16:55:00 volumio volumio[9401]: info: sendMpdCommand playlistinfo took 97 milliseconds May 04 16:55:00 volumio volumio[9401]: info: sendMpdCommand playlistinfo took 35 milliseconds May 04 16:55:00 volumio volumio[9401]: info: sendMpdCommand update took 2 milliseconds May 04 16:55:00 volumio volumio[9401]: info: ControllerMpd::getState May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::parseTrackInfo May 04 16:55:00 volumio volumio[9401]: info: ControllerMpd::pushState May 04 16:55:00 volumio volumio[9401]: info: CoreCommandRouter::servicePushState May 04 16:55:00 volumio volumio[9401]: info: CorePlayQueue::getTrack 0 May 04 16:55:00 volumio volumio[9401]: verbose: STATE SERVICE {"status":"play","position":0,"seek":850986,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grover Washington Jr. - In The Name Of Love","artist":"/SwissJazz_Room1","album":null,"uri":"https://stream.srg-ssr.ch/m/rsj/mp3_128","trackType":""} May 04 16:55:00 volumio volumio[9401]: verbose: CURRENT POSITION 0 May 04 16:55:00 volumio volumio[9401]: info: CoreStateMachine::syncState stateService play May 04 16:55:00 volumio volumio[9401]: info: CoreStateMachine::syncState currentStatus play May 04 16:55:00 volumio volumio[9401]: info: Received an update from plugin. extracting info from payload May 04 16:55:00 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:00 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:00 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:00 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:00 volumio volumio[9401]: info: ControllerMpd::pushState May 04 16:55:00 volumio volumio[9401]: info: CoreCommandRouter::servicePushState May 04 16:55:00 volumio volumio[9401]: info: CorePlayQueue::getTrack 0 May 04 16:55:00 volumio volumio[9401]: verbose: STATE SERVICE {"status":"play","position":0,"seek":851112,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grover Washington Jr. - In The Name Of Love","artist":"/SwissJazz_Room1","album":null,"uri":"https://stream.srg-ssr.ch/m/rsj/mp3_128","trackType":""} May 04 16:55:00 volumio volumio[9401]: verbose: CURRENT POSITION 0 May 04 16:55:00 volumio volumio[9401]: info: CoreStateMachine::syncState stateService play May 04 16:55:00 volumio volumio[9401]: info: CoreStateMachine::syncState currentStatus play May 04 16:55:00 volumio volumio[9401]: info: Received an update from plugin. extracting info from payload May 04 16:55:00 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:00 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:00 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:00 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:00 volumio volumio[9401]: info: ------------------------------ 303ms May 04 16:55:00 volumio volumio[9401]: info: ------------------------------ 125ms May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:00 volumio volumio[9401]: info: May 04 16:55:00 volumio volumio[9401]: ---------------------------- MPD announces state update: update May 04 16:55:00 volumio volumio[9401]: info: ControllerMpd::getState May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:00 volumio volumio[9401]: info: May 04 16:55:00 volumio volumio[9401]: ---------------------------- MPD announces state update: update May 04 16:55:00 volumio volumio[9401]: info: ControllerMpd::getState May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:00 volumio volumio[9401]: info: May 04 16:55:00 volumio volumio[9401]: ---------------------------- MPD announces state update: update May 04 16:55:00 volumio volumio[9401]: info: sendMpdCommand status took 26 milliseconds May 04 16:55:00 volumio volumio[9401]: info: sendMpdCommand status took 25 milliseconds May 04 16:55:00 volumio volumio[9401]: info: ControllerMpd::getState May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:00 volumio volumio[9401]: info: sendMpdCommand status took 2 milliseconds May 04 16:55:00 volumio volumio[9401]: info: sendMpdCommand status took 1 milliseconds May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:00 volumio volumio[9401]: info: Command Router : Notfying DB Updatetrue May 04 16:55:00 volumio volumio[9401]: info: CoreCommandRouter::Close All Modals sent May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:00 volumio volumio[9401]: info: Command Router : Notfying DB Updatefalse May 04 16:55:00 volumio volumio[9401]: info: CoreCommandRouter::Close All Modals sent May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:00 volumio volumio[9401]: info: Command Router : Notfying DB Updatefalse May 04 16:55:00 volumio volumio[9401]: info: CoreCommandRouter::Close All Modals sent May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:00 volumio volumio[9401]: info: May 04 16:55:00 volumio volumio[9401]: ---------------------------- MPD announces state update: update May 04 16:55:00 volumio volumio[9401]: info: ControllerMpd::getState May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:00 volumio volumio[9401]: info: May 04 16:55:00 volumio volumio[9401]: ---------------------------- MPD announces state update: update May 04 16:55:00 volumio volumio[9401]: info: ControllerMpd::getState May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:00 volumio volumio[9401]: info: sendMpdCommand status took 216 milliseconds May 04 16:55:00 volumio volumio[9401]: info: sendMpdCommand status took 215 milliseconds May 04 16:55:00 volumio volumio[9401]: info: sendMpdCommand status took 215 milliseconds May 04 16:55:00 volumio volumio[9401]: info: sendMpdCommand playlistinfo took 142 milliseconds May 04 16:55:00 volumio volumio[9401]: info: sendMpdCommand playlistinfo took 78 milliseconds May 04 16:55:00 volumio volumio[9401]: info: sendMpdCommand status took 3 milliseconds May 04 16:55:00 volumio volumio[9401]: info: sendMpdCommand status took 2 milliseconds May 04 16:55:00 volumio volumio[9401]: info: sendMpdCommand status took 2 milliseconds May 04 16:55:00 volumio volumio[9401]: info: sendMpdCommand status took 3 milliseconds May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 16:55:00 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:01 volumio volumio[9401]: info: Command Router : Notfying DB Updatefalse May 04 16:55:01 volumio volumio[9401]: info: CoreCommandRouter::Close All Modals sent May 04 16:55:01 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:01 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 16:55:01 volumio volumio[9401]: verbose: ControllerMpd::parseTrackInfo May 04 16:55:01 volumio volumio[9401]: verbose: ControllerMpd::parseTrackInfo May 04 16:55:01 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:01 volumio volumio[9401]: info: Command Router : Notfying DB Updatefalse May 04 16:55:01 volumio volumio[9401]: info: CoreCommandRouter::Close All Modals sent May 04 16:55:01 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:01 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 16:55:01 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:01 volumio volumio[9401]: info: Command Router : Notfying DB Updatefalse May 04 16:55:01 volumio volumio[9401]: info: CoreCommandRouter::Close All Modals sent May 04 16:55:01 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:01 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 16:55:01 volumio volumio[9401]: info: ControllerMpd::pushState May 04 16:55:01 volumio volumio[9401]: info: CoreCommandRouter::servicePushState May 04 16:55:01 volumio volumio[9401]: info: CorePlayQueue::getTrack 0 May 04 16:55:01 volumio volumio[9401]: verbose: STATE SERVICE {"status":"play","position":0,"seek":851237,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grover Washington Jr. - In The Name Of Love","artist":"/SwissJazz_Room1","album":null,"uri":"https://stream.srg-ssr.ch/m/rsj/mp3_128","trackType":""} May 04 16:55:01 volumio volumio[9401]: verbose: CURRENT POSITION 0 May 04 16:55:01 volumio volumio[9401]: info: CoreStateMachine::syncState stateService play May 04 16:55:01 volumio volumio[9401]: info: CoreStateMachine::syncState currentStatus play May 04 16:55:01 volumio volumio[9401]: info: Received an update from plugin. extracting info from payload May 04 16:55:01 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:01 volumio volumio[9401]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 04 16:55:01 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:01 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:01 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:01 volumio volumio[9401]: info: ControllerMpd::pushState May 04 16:55:01 volumio volumio[9401]: info: CoreCommandRouter::servicePushState May 04 16:55:01 volumio volumio[9401]: info: CorePlayQueue::getTrack 0 May 04 16:55:01 volumio volumio[9401]: verbose: STATE SERVICE {"status":"play","position":0,"seek":851237,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grover Washington Jr. - In The Name Of Love","artist":"/SwissJazz_Room1","album":null,"uri":"https://stream.srg-ssr.ch/m/rsj/mp3_128","trackType":""} May 04 16:55:01 volumio volumio[9401]: verbose: CURRENT POSITION 0 May 04 16:55:01 volumio volumio[9401]: info: CoreStateMachine::syncState stateService play May 04 16:55:01 volumio volumio[9401]: info: CoreStateMachine::syncState currentStatus play May 04 16:55:01 volumio volumio[9401]: info: Received an update from plugin. extracting info from payload May 04 16:55:01 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:01 volumio volumio[9401]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 04 16:55:01 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:01 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:01 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:01 volumio volumio[9401]: info: ------------------------------ 472ms May 04 16:55:01 volumio volumio[9401]: info: ------------------------------ 448ms May 04 16:55:01 volumio volumio[9401]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb May 04 16:55:01 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand update May 04 16:55:01 volumio volumio[9401]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb May 04 16:55:01 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand update May 04 16:55:01 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:01 volumio volumio[9401]: info: May 04 16:55:01 volumio volumio[9401]: ---------------------------- MPD announces state update: update May 04 16:55:01 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:01 volumio volumio[9401]: info: May 04 16:55:01 volumio volumio[9401]: ---------------------------- MPD announces state update: update May 04 16:55:01 volumio volumio[9401]: info: sendMpdCommand playlistinfo took 241 milliseconds May 04 16:55:01 volumio volumio[9401]: info: sendMpdCommand playlistinfo took 162 milliseconds May 04 16:55:01 volumio volumio[9401]: info: sendMpdCommand playlistinfo took 97 milliseconds May 04 16:55:01 volumio volumio[9401]: info: sendMpdCommand playlistinfo took 41 milliseconds May 04 16:55:01 volumio volumio[9401]: info: sendMpdCommand update took 6 milliseconds May 04 16:55:01 volumio volumio[9401]: info: ControllerMpd::getState May 04 16:55:01 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:01 volumio volumio[9401]: info: sendMpdCommand update took 5 milliseconds May 04 16:55:01 volumio volumio[9401]: info: ControllerMpd::getState May 04 16:55:01 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:01 volumio volumio[9401]: verbose: ControllerMpd::parseTrackInfo May 04 16:55:01 volumio volumio[9401]: verbose: ControllerMpd::parseTrackInfo May 04 16:55:01 volumio volumio[9401]: verbose: ControllerMpd::parseTrackInfo May 04 16:55:01 volumio volumio[9401]: verbose: ControllerMpd::parseTrackInfo May 04 16:55:01 volumio volumio[9401]: info: ControllerMpd::pushState May 04 16:55:01 volumio volumio[9401]: info: CoreCommandRouter::servicePushState May 04 16:55:01 volumio volumio[9401]: info: CorePlayQueue::getTrack 0 May 04 16:55:01 volumio volumio[9401]: verbose: STATE SERVICE {"status":"play","position":0,"seek":851237,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grover Washington Jr. - In The Name Of Love","artist":"/SwissJazz_Room1","album":null,"uri":"https://stream.srg-ssr.ch/m/rsj/mp3_128","trackType":""} May 04 16:55:01 volumio volumio[9401]: verbose: CURRENT POSITION 0 May 04 16:55:01 volumio volumio[9401]: info: CoreStateMachine::syncState stateService play May 04 16:55:01 volumio volumio[9401]: info: CoreStateMachine::syncState currentStatus play May 04 16:55:01 volumio volumio[9401]: info: Received an update from plugin. extracting info from payload May 04 16:55:01 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:01 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:01 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:01 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:01 volumio volumio[9401]: info: ControllerMpd::pushState May 04 16:55:01 volumio volumio[9401]: info: CoreCommandRouter::servicePushState May 04 16:55:01 volumio volumio[9401]: info: CorePlayQueue::getTrack 0 May 04 16:55:01 volumio volumio[9401]: verbose: STATE SERVICE {"status":"play","position":0,"seek":851363,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grover Washington Jr. - In The Name Of Love","artist":"/SwissJazz_Room1","album":null,"uri":"https://stream.srg-ssr.ch/m/rsj/mp3_128","trackType":""} May 04 16:55:01 volumio volumio[9401]: verbose: CURRENT POSITION 0 May 04 16:55:01 volumio volumio[9401]: info: CoreStateMachine::syncState stateService play May 04 16:55:01 volumio volumio[9401]: info: CoreStateMachine::syncState currentStatus play May 04 16:55:01 volumio volumio[9401]: info: Received an update from plugin. extracting info from payload May 04 16:55:01 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:01 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:01 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:01 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:01 volumio volumio[9401]: info: ControllerMpd::pushState May 04 16:55:01 volumio volumio[9401]: info: CoreCommandRouter::servicePushState May 04 16:55:01 volumio volumio[9401]: info: CorePlayQueue::getTrack 0 May 04 16:55:01 volumio volumio[9401]: verbose: STATE SERVICE {"status":"play","position":0,"seek":851488,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grover Washington Jr. - In The Name Of Love","artist":"/SwissJazz_Room1","album":null,"uri":"https://stream.srg-ssr.ch/m/rsj/mp3_128","trackType":""} May 04 16:55:01 volumio volumio[9401]: verbose: CURRENT POSITION 0 May 04 16:55:01 volumio volumio[9401]: info: CoreStateMachine::syncState stateService play May 04 16:55:01 volumio volumio[9401]: info: CoreStateMachine::syncState currentStatus play May 04 16:55:01 volumio volumio[9401]: info: Received an update from plugin. extracting info from payload May 04 16:55:01 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:01 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:01 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:01 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:01 volumio volumio[9401]: info: ControllerMpd::pushState May 04 16:55:01 volumio volumio[9401]: info: CoreCommandRouter::servicePushState May 04 16:55:01 volumio volumio[9401]: info: CorePlayQueue::getTrack 0 May 04 16:55:01 volumio volumio[9401]: verbose: STATE SERVICE {"status":"play","position":0,"seek":851488,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grover Washington Jr. - In The Name Of Love","artist":"/SwissJazz_Room1","album":null,"uri":"https://stream.srg-ssr.ch/m/rsj/mp3_128","trackType":""} May 04 16:55:01 volumio volumio[9401]: verbose: CURRENT POSITION 0 May 04 16:55:01 volumio volumio[9401]: info: CoreStateMachine::syncState stateService play May 04 16:55:01 volumio volumio[9401]: info: CoreStateMachine::syncState currentStatus play May 04 16:55:01 volumio volumio[9401]: info: Received an update from plugin. extracting info from payload May 04 16:55:01 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:01 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:01 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:01 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:01 volumio volumio[9401]: info: ------------------------------ 498ms May 04 16:55:01 volumio volumio[9401]: info: ------------------------------ 498ms May 04 16:55:01 volumio volumio[9401]: info: ------------------------------ 286ms May 04 16:55:01 volumio volumio[9401]: info: ------------------------------ 285ms May 04 16:55:01 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:01 volumio volumio[9401]: info: May 04 16:55:01 volumio volumio[9401]: ---------------------------- MPD announces state update: update May 04 16:55:01 volumio volumio[9401]: info: ControllerMpd::getState May 04 16:55:01 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:01 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:01 volumio volumio[9401]: info: May 04 16:55:01 volumio volumio[9401]: ---------------------------- MPD announces state update: update May 04 16:55:01 volumio volumio[9401]: info: ControllerMpd::getState May 04 16:55:01 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:01 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:01 volumio volumio[9401]: info: May 04 16:55:01 volumio volumio[9401]: ---------------------------- MPD announces state update: update May 04 16:55:01 volumio volumio[9401]: info: ControllerMpd::getState May 04 16:55:01 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:01 volumio volumio[9401]: info: sendMpdCommand status took 47 milliseconds May 04 16:55:01 volumio volumio[9401]: info: sendMpdCommand status took 47 milliseconds May 04 16:55:01 volumio volumio[9401]: info: sendMpdCommand status took 46 milliseconds May 04 16:55:01 volumio volumio[9401]: info: sendMpdCommand status took 46 milliseconds May 04 16:55:01 volumio volumio[9401]: info: sendMpdCommand status took 4 milliseconds May 04 16:55:01 volumio volumio[9401]: info: sendMpdCommand status took 4 milliseconds May 04 16:55:01 volumio volumio[9401]: info: sendMpdCommand status took 3 milliseconds May 04 16:55:01 volumio volumio[9401]: info: sendMpdCommand status took 3 milliseconds May 04 16:55:01 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:01 volumio volumio[9401]: info: Command Router : Notfying DB Updatefalse May 04 16:55:01 volumio volumio[9401]: info: CoreCommandRouter::Close All Modals sent May 04 16:55:01 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:01 volumio volumio[9401]: info: Command Router : Notfying DB Updatefalse May 04 16:55:01 volumio volumio[9401]: info: CoreCommandRouter::Close All Modals sent May 04 16:55:01 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:01 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 16:55:01 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:01 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 16:55:01 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:01 volumio volumio[9401]: info: Command Router : Notfying DB Updatefalse May 04 16:55:01 volumio volumio[9401]: info: CoreCommandRouter::Close All Modals sent May 04 16:55:01 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:01 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 16:55:01 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:01 volumio volumio[9401]: info: Command Router : Notfying DB Updatefalse May 04 16:55:01 volumio volumio[9401]: info: CoreCommandRouter::Close All Modals sent May 04 16:55:01 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:01 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 16:55:01 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:01 volumio volumio[9401]: info: May 04 16:55:01 volumio volumio[9401]: ---------------------------- MPD announces state update: update May 04 16:55:01 volumio volumio[9401]: info: ControllerMpd::getState May 04 16:55:01 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:01 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:01 volumio volumio[9401]: info: May 04 16:55:01 volumio volumio[9401]: ---------------------------- MPD announces state update: update May 04 16:55:01 volumio volumio[9401]: info: ControllerMpd::getState May 04 16:55:01 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:01 volumio volumio[9401]: info: sendMpdCommand status took 71 milliseconds May 04 16:55:01 volumio volumio[9401]: info: sendMpdCommand status took 70 milliseconds May 04 16:55:01 volumio volumio[9401]: info: sendMpdCommand playlistinfo took 40 milliseconds May 04 16:55:01 volumio volumio[9401]: info: sendMpdCommand playlistinfo took 40 milliseconds May 04 16:55:01 volumio volumio[9401]: info: sendMpdCommand playlistinfo took 26 milliseconds May 04 16:55:01 volumio volumio[9401]: info: sendMpdCommand playlistinfo took 13 milliseconds May 04 16:55:01 volumio volumio[9401]: info: sendMpdCommand status took 2 milliseconds May 04 16:55:01 volumio volumio[9401]: info: sendMpdCommand status took 2 milliseconds May 04 16:55:01 volumio volumio[9401]: info: sendMpdCommand status took 1 milliseconds May 04 16:55:01 volumio volumio[9401]: info: sendMpdCommand status took 2 milliseconds May 04 16:55:01 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:01 volumio volumio[9401]: info: Command Router : Notfying DB Updatefalse May 04 16:55:01 volumio volumio[9401]: info: CoreCommandRouter::Close All Modals sent May 04 16:55:01 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:01 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 16:55:01 volumio volumio[9401]: verbose: ControllerMpd::parseTrackInfo May 04 16:55:01 volumio volumio[9401]: verbose: ControllerMpd::parseTrackInfo May 04 16:55:01 volumio volumio[9401]: verbose: ControllerMpd::parseTrackInfo May 04 16:55:01 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:01 volumio volumio[9401]: info: Command Router : Notfying DB Updatefalse May 04 16:55:01 volumio volumio[9401]: info: CoreCommandRouter::Close All Modals sent May 04 16:55:01 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:01 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 16:55:01 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:01 volumio volumio[9401]: info: Command Router : Notfying DB Updatefalse May 04 16:55:01 volumio volumio[9401]: info: CoreCommandRouter::Close All Modals sent May 04 16:55:01 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:01 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 16:55:01 volumio volumio[9401]: info: ControllerMpd::pushState May 04 16:55:01 volumio volumio[9401]: info: CoreCommandRouter::servicePushState May 04 16:55:01 volumio volumio[9401]: info: CorePlayQueue::getTrack 0 May 04 16:55:01 volumio volumio[9401]: verbose: STATE SERVICE {"status":"play","position":0,"seek":851729,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grover Washington Jr. - In The Name Of Love","artist":"/SwissJazz_Room1","album":null,"uri":"https://stream.srg-ssr.ch/m/rsj/mp3_128","trackType":""} May 04 16:55:01 volumio volumio[9401]: verbose: CURRENT POSITION 0 May 04 16:55:01 volumio volumio[9401]: info: CoreStateMachine::syncState stateService play May 04 16:55:01 volumio volumio[9401]: info: CoreStateMachine::syncState currentStatus play May 04 16:55:01 volumio volumio[9401]: info: Received an update from plugin. extracting info from payload May 04 16:55:01 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:01 volumio volumio[9401]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 04 16:55:01 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:01 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:01 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:01 volumio volumio[9401]: info: ControllerMpd::pushState May 04 16:55:01 volumio volumio[9401]: info: CoreCommandRouter::servicePushState May 04 16:55:01 volumio volumio[9401]: info: CorePlayQueue::getTrack 0 May 04 16:55:01 volumio volumio[9401]: verbose: STATE SERVICE {"status":"play","position":0,"seek":851729,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grover Washington Jr. - In The Name Of Love","artist":"/SwissJazz_Room1","album":null,"uri":"https://stream.srg-ssr.ch/m/rsj/mp3_128","trackType":""} May 04 16:55:01 volumio volumio[9401]: verbose: CURRENT POSITION 0 May 04 16:55:01 volumio volumio[9401]: info: CoreStateMachine::syncState stateService play May 04 16:55:01 volumio volumio[9401]: info: CoreStateMachine::syncState currentStatus play May 04 16:55:01 volumio volumio[9401]: info: Received an update from plugin. extracting info from payload May 04 16:55:01 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:01 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:01 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:01 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:01 volumio volumio[9401]: info: ControllerMpd::pushState May 04 16:55:01 volumio volumio[9401]: info: CoreCommandRouter::servicePushState May 04 16:55:01 volumio volumio[9401]: info: CorePlayQueue::getTrack 0 May 04 16:55:01 volumio volumio[9401]: verbose: STATE SERVICE {"status":"play","position":0,"seek":851729,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grover Washington Jr. - In The Name Of Love","artist":"/SwissJazz_Room1","album":null,"uri":"https://stream.srg-ssr.ch/m/rsj/mp3_128","trackType":""} May 04 16:55:01 volumio volumio[9401]: verbose: CURRENT POSITION 0 May 04 16:55:01 volumio volumio[9401]: info: CoreStateMachine::syncState stateService play May 04 16:55:01 volumio volumio[9401]: info: CoreStateMachine::syncState currentStatus play May 04 16:55:01 volumio volumio[9401]: info: Received an update from plugin. extracting info from payload May 04 16:55:01 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:01 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:01 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:01 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:01 volumio volumio[9401]: info: ControllerMpd::pushState May 04 16:55:01 volumio volumio[9401]: info: CoreCommandRouter::servicePushState May 04 16:55:01 volumio volumio[9401]: info: CorePlayQueue::getTrack 0 May 04 16:55:01 volumio volumio[9401]: verbose: STATE SERVICE {"status":"play","position":0,"seek":851729,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grover Washington Jr. - In The Name Of Love","artist":"/SwissJazz_Room1","album":null,"uri":"https://stream.srg-ssr.ch/m/rsj/mp3_128","trackType":""} May 04 16:55:01 volumio volumio[9401]: verbose: CURRENT POSITION 0 May 04 16:55:01 volumio volumio[9401]: info: CoreStateMachine::syncState stateService play May 04 16:55:01 volumio volumio[9401]: info: CoreStateMachine::syncState currentStatus play May 04 16:55:01 volumio volumio[9401]: info: Received an update from plugin. extracting info from payload May 04 16:55:01 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:01 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:01 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:01 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:01 volumio volumio[9401]: info: ------------------------------ 208ms May 04 16:55:01 volumio volumio[9401]: info: ------------------------------ 209ms May 04 16:55:01 volumio volumio[9401]: info: ------------------------------ 165ms May 04 16:55:01 volumio volumio[9401]: info: ------------------------------ 164ms May 04 16:55:01 volumio volumio[9401]: info: sendMpdCommand playlistinfo took 82 milliseconds May 04 16:55:01 volumio volumio[9401]: info: sendMpdCommand playlistinfo took 66 milliseconds May 04 16:55:01 volumio volumio[9401]: info: sendMpdCommand playlistinfo took 51 milliseconds May 04 16:55:01 volumio volumio[9401]: verbose: ControllerMpd::parseTrackInfo May 04 16:55:01 volumio volumio[9401]: verbose: ControllerMpd::parseTrackInfo May 04 16:55:01 volumio volumio[9401]: verbose: ControllerMpd::parseTrackInfo May 04 16:55:01 volumio volumio[9401]: info: ControllerMpd::pushState May 04 16:55:01 volumio volumio[9401]: info: CoreCommandRouter::servicePushState May 04 16:55:01 volumio volumio[9401]: info: CorePlayQueue::getTrack 0 May 04 16:55:01 volumio volumio[9401]: verbose: STATE SERVICE {"status":"play","position":0,"seek":851729,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grover Washington Jr. - In The Name Of Love","artist":"/SwissJazz_Room1","album":null,"uri":"https://stream.srg-ssr.ch/m/rsj/mp3_128","trackType":""} May 04 16:55:01 volumio volumio[9401]: verbose: CURRENT POSITION 0 May 04 16:55:01 volumio volumio[9401]: info: CoreStateMachine::syncState stateService play May 04 16:55:01 volumio volumio[9401]: info: CoreStateMachine::syncState currentStatus play May 04 16:55:01 volumio volumio[9401]: info: Received an update from plugin. extracting info from payload May 04 16:55:01 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:01 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:01 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:01 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:01 volumio volumio[9401]: info: ControllerMpd::pushState May 04 16:55:01 volumio volumio[9401]: info: CoreCommandRouter::servicePushState May 04 16:55:01 volumio volumio[9401]: info: CorePlayQueue::getTrack 0 May 04 16:55:01 volumio volumio[9401]: verbose: STATE SERVICE {"status":"play","position":0,"seek":851854,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grover Washington Jr. - In The Name Of Love","artist":"/SwissJazz_Room1","album":null,"uri":"https://stream.srg-ssr.ch/m/rsj/mp3_128","trackType":""} May 04 16:55:01 volumio volumio[9401]: verbose: CURRENT POSITION 0 May 04 16:55:01 volumio volumio[9401]: info: CoreStateMachine::syncState stateService play May 04 16:55:01 volumio volumio[9401]: info: CoreStateMachine::syncState currentStatus play May 04 16:55:01 volumio volumio[9401]: info: Received an update from plugin. extracting info from payload May 04 16:55:01 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:01 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:01 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:01 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:01 volumio volumio[9401]: info: ControllerMpd::pushState May 04 16:55:01 volumio volumio[9401]: info: CoreCommandRouter::servicePushState May 04 16:55:01 volumio volumio[9401]: info: CorePlayQueue::getTrack 0 May 04 16:55:01 volumio volumio[9401]: verbose: STATE SERVICE {"status":"play","position":0,"seek":851854,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grover Washington Jr. - In The Name Of Love","artist":"/SwissJazz_Room1","album":null,"uri":"https://stream.srg-ssr.ch/m/rsj/mp3_128","trackType":""} May 04 16:55:01 volumio volumio[9401]: verbose: CURRENT POSITION 0 May 04 16:55:01 volumio volumio[9401]: info: CoreStateMachine::syncState stateService play May 04 16:55:01 volumio volumio[9401]: info: CoreStateMachine::syncState currentStatus play May 04 16:55:01 volumio volumio[9401]: info: Received an update from plugin. extracting info from payload May 04 16:55:01 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:01 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:01 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:01 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:01 volumio volumio[9401]: info: ------------------------------ 197ms May 04 16:55:01 volumio volumio[9401]: info: ------------------------------ 129ms May 04 16:55:01 volumio volumio[9401]: info: ------------------------------ 129ms May 04 16:55:01 volumio volumio[9401]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 04 16:55:01 volumio kernel: intel ips 0000:00:1f.6: failed to disable graphics turbo May 04 16:55:05 volumio volumio[9401]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 04 16:55:06 volumio volumio[9401]: info: CoreCommandRouter::volumioGetState May 04 16:55:06 volumio volumio[9401]: info: Listing playlists May 04 16:55:06 volumio volumio[9401]: info: Listing playlists May 04 16:55:06 volumio kernel: intel ips 0000:00:1f.6: failed to disable graphics turbo May 04 16:55:09 volumio volumio[9401]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 04 16:55:12 volumio kernel: intel ips 0000:00:1f.6: failed to disable graphics turbo May 04 16:55:12 volumio kernel: usb 1-1.2: USB disconnect, device number 3 May 04 16:55:12 volumio volumio[9401]: info: Partition removed: {"syspath":"/sys/devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1.2/1-1.2:1.0/host0/target0:0:0/0:0:0:0/block/sdb/sdb1","ACTION":"remove","DEVLINKS":"/dev/disk/by-label/DATA /dev/disk/by-id/usb-ST350083_0A_00830A222222-0:0-part1 /dev/disk/by-uuid/166AD4E36AD4C123 /dev/disk/by-path/pci-0000:00:1a.0-usb-0:1.2:1.0-scsi-0:0:0:0-part1 /dev/disk/by-partuuid/f89b8386-01","DEVNAME":"/dev/sdb1","DEVPATH":"/devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1.2/1-1.2:1.0/host0/target0:0:0/0:0:0:0/block/sdb/sdb1","DEVTYPE":"partition","DISKSEQ":"2","ID_BUS":"usb","ID_FS_LABEL":"DATA","ID_FS_LABEL_ENC":"DATA","ID_FS_TYPE":"ntfs","ID_FS_USAGE":"filesystem","ID_FS_UUID":"166AD4E36AD4C123","ID_FS_UUID_ENC":"166AD4E36AD4C123","ID_INSTANCE":"0:0","ID_MODEL":"0A","ID_MODEL_ENC":"0A\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20","ID_MODEL_ID":"00d5","ID_PART_ENTRY_DISK":"8:16","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"2048","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"976769024","ID_PART_ENTRY_TYPE":"0x7","ID_PART_ENTRY_UUID":"f89b8386-01","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"f89b8386","ID_PATH":"pci-0000:00:1a.0-usb-0:1.2:1.0-scsi-0:0:0:0","ID_PATH_TAG":"pci-0000_00_1a_0-usb-0_1_2_1_0-scsi-0_0_0_0","ID_REVISION":"0000","ID_SERIAL":"ST350083_0A_00830A222222-0:0","ID_SERIAL_SHORT":"00830A222222","ID_TYPE":"disk","ID_USB_DRIVER":"usb-storage","ID_USB_INTERFACES":":080650:","ID_USB_INTERFACE_NUM":"00","ID_VENDOR":"ST350083","ID_VENDOR_ENC":"ST350083","ID_VENDOR_ID":"0dc4","MAJOR":"8","MINOR":"17","PARTN":"1","SEQNUM":"3313","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"3375984"} May 04 16:55:13 volumio volumio[9401]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 04 16:55:16 volumio volumio[9401]: info: CoreCommandRouter::volumioGetState May 04 16:55:17 volumio kernel: intel ips 0000:00:1f.6: failed to disable graphics turbo May 04 16:55:17 volumio volumio[9401]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 04 16:55:21 volumio volumio[9401]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 04 16:55:21 volumio volumio[9401]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb May 04 16:55:21 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand update May 04 16:55:21 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:21 volumio volumio[9401]: info: May 04 16:55:21 volumio volumio[9401]: ---------------------------- MPD announces state update: update May 04 16:55:21 volumio volumio[9401]: info: sendMpdCommand update took 1 milliseconds May 04 16:55:21 volumio volumio[9401]: info: ControllerMpd::getState May 04 16:55:21 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:21 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:21 volumio volumio[9401]: info: May 04 16:55:21 volumio volumio[9401]: ---------------------------- MPD announces state update: update May 04 16:55:21 volumio volumio[9401]: info: ControllerMpd::getState May 04 16:55:21 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:21 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:21 volumio volumio[9401]: info: May 04 16:55:21 volumio volumio[9401]: ---------------------------- MPD announces state update: update May 04 16:55:21 volumio volumio[9401]: info: ControllerMpd::getState May 04 16:55:21 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:21 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:21 volumio volumio[9401]: info: May 04 16:55:21 volumio volumio[9401]: ---------------------------- MPD announces state update: update May 04 16:55:21 volumio volumio[9401]: info: ControllerMpd::getState May 04 16:55:21 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:21 volumio volumio[9401]: info: sendMpdCommand status took 5 milliseconds May 04 16:55:21 volumio volumio[9401]: info: sendMpdCommand status took 5 milliseconds May 04 16:55:21 volumio volumio[9401]: info: sendMpdCommand status took 4 milliseconds May 04 16:55:21 volumio volumio[9401]: info: sendMpdCommand status took 4 milliseconds May 04 16:55:21 volumio volumio[9401]: info: sendMpdCommand status took 3 milliseconds May 04 16:55:21 volumio volumio[9401]: info: sendMpdCommand status took 3 milliseconds May 04 16:55:21 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:21 volumio volumio[9401]: info: Command Router : Notfying DB Updatefalse May 04 16:55:21 volumio volumio[9401]: info: CoreCommandRouter::Close All Modals sent May 04 16:55:21 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:21 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 16:55:21 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:21 volumio volumio[9401]: info: Command Router : Notfying DB Updatefalse May 04 16:55:21 volumio volumio[9401]: info: CoreCommandRouter::Close All Modals sent May 04 16:55:21 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:21 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 16:55:21 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:21 volumio volumio[9401]: info: Command Router : Notfying DB Updatefalse May 04 16:55:21 volumio volumio[9401]: info: CoreCommandRouter::Close All Modals sent May 04 16:55:21 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:21 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 16:55:21 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:21 volumio volumio[9401]: info: May 04 16:55:21 volumio volumio[9401]: ---------------------------- MPD announces state update: update May 04 16:55:21 volumio volumio[9401]: info: ControllerMpd::getState May 04 16:55:21 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:21 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:21 volumio volumio[9401]: info: May 04 16:55:21 volumio volumio[9401]: ---------------------------- MPD announces state update: update May 04 16:55:21 volumio volumio[9401]: info: ControllerMpd::getState May 04 16:55:21 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:21 volumio volumio[9401]: info: sendMpdCommand status took 259 milliseconds May 04 16:55:21 volumio volumio[9401]: info: sendMpdCommand status took 258 milliseconds May 04 16:55:21 volumio volumio[9401]: info: sendMpdCommand playlistinfo took 118 milliseconds May 04 16:55:21 volumio volumio[9401]: info: sendMpdCommand playlistinfo took 24 milliseconds May 04 16:55:21 volumio volumio[9401]: info: sendMpdCommand playlistinfo took 8 milliseconds May 04 16:55:21 volumio volumio[9401]: info: sendMpdCommand status took 3 milliseconds May 04 16:55:21 volumio volumio[9401]: info: sendMpdCommand status took 2 milliseconds May 04 16:55:21 volumio volumio[9401]: info: sendMpdCommand status took 2 milliseconds May 04 16:55:21 volumio volumio[9401]: info: sendMpdCommand status took 2 milliseconds May 04 16:55:21 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:21 volumio volumio[9401]: info: Command Router : Notfying DB Updatefalse May 04 16:55:21 volumio volumio[9401]: info: CoreCommandRouter::Close All Modals sent May 04 16:55:21 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:21 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 16:55:21 volumio volumio[9401]: verbose: ControllerMpd::parseTrackInfo May 04 16:55:21 volumio volumio[9401]: verbose: ControllerMpd::parseTrackInfo May 04 16:55:21 volumio volumio[9401]: verbose: ControllerMpd::parseTrackInfo May 04 16:55:21 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:21 volumio volumio[9401]: info: Command Router : Notfying DB Updatefalse May 04 16:55:21 volumio volumio[9401]: info: CoreCommandRouter::Close All Modals sent May 04 16:55:21 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:21 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 16:55:21 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:21 volumio volumio[9401]: info: Command Router : Notfying DB Updatefalse May 04 16:55:21 volumio volumio[9401]: info: CoreCommandRouter::Close All Modals sent May 04 16:55:21 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:21 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 16:55:21 volumio volumio[9401]: info: ControllerMpd::pushState May 04 16:55:21 volumio volumio[9401]: info: CoreCommandRouter::servicePushState May 04 16:55:21 volumio volumio[9401]: info: CorePlayQueue::getTrack 0 May 04 16:55:21 volumio volumio[9401]: verbose: STATE SERVICE {"status":"play","position":0,"seek":872112,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grover Washington Jr. - In The Name Of Love","artist":"/SwissJazz_Room1","album":null,"uri":"https://stream.srg-ssr.ch/m/rsj/mp3_128","trackType":""} May 04 16:55:21 volumio volumio[9401]: verbose: CURRENT POSITION 0 May 04 16:55:21 volumio volumio[9401]: info: CoreStateMachine::syncState stateService play May 04 16:55:21 volumio volumio[9401]: info: CoreStateMachine::syncState currentStatus play May 04 16:55:21 volumio volumio[9401]: info: Received an update from plugin. extracting info from payload May 04 16:55:21 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:21 volumio volumio[9401]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 04 16:55:21 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:21 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:21 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:21 volumio volumio[9401]: info: ControllerMpd::pushState May 04 16:55:21 volumio volumio[9401]: info: CoreCommandRouter::servicePushState May 04 16:55:21 volumio volumio[9401]: info: CorePlayQueue::getTrack 0 May 04 16:55:21 volumio volumio[9401]: verbose: STATE SERVICE {"status":"play","position":0,"seek":872112,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grover Washington Jr. - In The Name Of Love","artist":"/SwissJazz_Room1","album":null,"uri":"https://stream.srg-ssr.ch/m/rsj/mp3_128","trackType":""} May 04 16:55:21 volumio volumio[9401]: verbose: CURRENT POSITION 0 May 04 16:55:21 volumio volumio[9401]: info: CoreStateMachine::syncState stateService play May 04 16:55:21 volumio volumio[9401]: info: CoreStateMachine::syncState currentStatus play May 04 16:55:21 volumio volumio[9401]: info: Received an update from plugin. extracting info from payload May 04 16:55:21 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:21 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:21 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:21 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:21 volumio volumio[9401]: info: ControllerMpd::pushState May 04 16:55:21 volumio volumio[9401]: info: CoreCommandRouter::servicePushState May 04 16:55:21 volumio volumio[9401]: info: CorePlayQueue::getTrack 0 May 04 16:55:21 volumio volumio[9401]: verbose: STATE SERVICE {"status":"play","position":0,"seek":872112,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grover Washington Jr. - In The Name Of Love","artist":"/SwissJazz_Room1","album":null,"uri":"https://stream.srg-ssr.ch/m/rsj/mp3_128","trackType":""} May 04 16:55:21 volumio volumio[9401]: verbose: CURRENT POSITION 0 May 04 16:55:21 volumio volumio[9401]: info: CoreStateMachine::syncState stateService play May 04 16:55:21 volumio volumio[9401]: info: CoreStateMachine::syncState currentStatus play May 04 16:55:21 volumio volumio[9401]: info: Received an update from plugin. extracting info from payload May 04 16:55:21 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:21 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:21 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:21 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:21 volumio volumio[9401]: info: ------------------------------ 346ms May 04 16:55:21 volumio volumio[9401]: info: ------------------------------ 345ms May 04 16:55:21 volumio volumio[9401]: info: ------------------------------ 344ms May 04 16:55:21 volumio volumio[9401]: info: sendMpdCommand playlistinfo took 74 milliseconds May 04 16:55:21 volumio volumio[9401]: info: sendMpdCommand playlistinfo took 59 milliseconds May 04 16:55:21 volumio volumio[9401]: info: sendMpdCommand playlistinfo took 46 milliseconds May 04 16:55:21 volumio volumio[9401]: verbose: ControllerMpd::parseTrackInfo May 04 16:55:21 volumio volumio[9401]: verbose: ControllerMpd::parseTrackInfo May 04 16:55:21 volumio volumio[9401]: verbose: ControllerMpd::parseTrackInfo May 04 16:55:21 volumio volumio[9401]: info: ControllerMpd::pushState May 04 16:55:21 volumio volumio[9401]: info: CoreCommandRouter::servicePushState May 04 16:55:21 volumio volumio[9401]: info: CorePlayQueue::getTrack 0 May 04 16:55:21 volumio volumio[9401]: verbose: STATE SERVICE {"status":"play","position":0,"seek":872112,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grover Washington Jr. - In The Name Of Love","artist":"/SwissJazz_Room1","album":null,"uri":"https://stream.srg-ssr.ch/m/rsj/mp3_128","trackType":""} May 04 16:55:21 volumio volumio[9401]: verbose: CURRENT POSITION 0 May 04 16:55:21 volumio volumio[9401]: info: CoreStateMachine::syncState stateService play May 04 16:55:21 volumio volumio[9401]: info: CoreStateMachine::syncState currentStatus play May 04 16:55:21 volumio volumio[9401]: info: Received an update from plugin. extracting info from payload May 04 16:55:21 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:21 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:21 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:21 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:21 volumio volumio[9401]: info: ControllerMpd::pushState May 04 16:55:21 volumio volumio[9401]: info: CoreCommandRouter::servicePushState May 04 16:55:21 volumio volumio[9401]: info: CorePlayQueue::getTrack 0 May 04 16:55:21 volumio volumio[9401]: verbose: STATE SERVICE {"status":"play","position":0,"seek":872363,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grover Washington Jr. - In The Name Of Love","artist":"/SwissJazz_Room1","album":null,"uri":"https://stream.srg-ssr.ch/m/rsj/mp3_128","trackType":""} May 04 16:55:21 volumio volumio[9401]: verbose: CURRENT POSITION 0 May 04 16:55:21 volumio volumio[9401]: info: CoreStateMachine::syncState stateService play May 04 16:55:21 volumio volumio[9401]: info: CoreStateMachine::syncState currentStatus play May 04 16:55:21 volumio volumio[9401]: info: Received an update from plugin. extracting info from payload May 04 16:55:21 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:21 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:21 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:21 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:21 volumio volumio[9401]: info: ControllerMpd::pushState May 04 16:55:21 volumio volumio[9401]: info: CoreCommandRouter::servicePushState May 04 16:55:21 volumio volumio[9401]: info: CorePlayQueue::getTrack 0 May 04 16:55:21 volumio volumio[9401]: verbose: STATE SERVICE {"status":"play","position":0,"seek":872363,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grover Washington Jr. - In The Name Of Love","artist":"/SwissJazz_Room1","album":null,"uri":"https://stream.srg-ssr.ch/m/rsj/mp3_128","trackType":""} May 04 16:55:21 volumio volumio[9401]: verbose: CURRENT POSITION 0 May 04 16:55:21 volumio volumio[9401]: info: CoreStateMachine::syncState stateService play May 04 16:55:21 volumio volumio[9401]: info: CoreStateMachine::syncState currentStatus play May 04 16:55:21 volumio volumio[9401]: info: Received an update from plugin. extracting info from payload May 04 16:55:21 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:21 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:21 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:21 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:21 volumio volumio[9401]: info: ------------------------------ 379ms May 04 16:55:21 volumio volumio[9401]: info: ------------------------------ 122ms May 04 16:55:21 volumio volumio[9401]: info: ------------------------------ 122ms May 04 16:55:22 volumio kernel: usb 1-1.2: new high-speed USB device number 4 using ehci-pci May 04 16:55:22 volumio kernel: usb 1-1.2: New USB device found, idVendor=0dc4, idProduct=00d5, bcdDevice= 0.00 May 04 16:55:22 volumio kernel: usb 1-1.2: New USB device strings: Mfr=10, Product=11, SerialNumber=5 May 04 16:55:22 volumio kernel: usb 1-1.2: Product: Store & Play 3500 May 04 16:55:22 volumio kernel: usb 1-1.2: Manufacturer: Packard Bell May 04 16:55:22 volumio kernel: usb 1-1.2: SerialNumber: 00830A222222 May 04 16:55:22 volumio kernel: usb-storage 1-1.2:1.0: USB Mass Storage device detected May 04 16:55:22 volumio kernel: scsi host7: usb-storage 1-1.2:1.0 May 04 16:55:22 volumio kernel: intel ips 0000:00:1f.6: failed to disable graphics turbo May 04 16:55:23 volumio kernel: scsi 7:0:0:0: Direct-Access ST350083 0A PQ: 0 ANSI: 2 CCS May 04 16:55:23 volumio kernel: sd 7:0:0:0: Attached scsi generic sg1 type 0 May 04 16:55:23 volumio kernel: sd 7:0:0:0: [sdc] 976773168 512-byte logical blocks: (500 GB/466 GiB) May 04 16:55:23 volumio kernel: sd 7:0:0:0: [sdc] Write Protect is off May 04 16:55:23 volumio kernel: sd 7:0:0:0: [sdc] Mode Sense: 00 38 00 00 May 04 16:55:23 volumio kernel: sd 7:0:0:0: [sdc] Asking for cache data failed May 04 16:55:23 volumio kernel: sd 7:0:0:0: [sdc] Assuming drive cache: write through May 04 16:55:23 volumio kernel: sdc: sdc1 May 04 16:55:23 volumio kernel: sd 7:0:0:0: [sdc] Attached SCSI disk May 04 16:55:23 volumio volumio[9401]: info: Mounting Device DATA May 04 16:55:23 volumio volumio[9401]: /bin/mkdir: cannot create directory ‘/mnt/USB/DATA’: File exists May 04 16:55:23 volumio volumio[9401]: error: Failed to create folder Error: Command failed: /bin/mkdir -m 777 "/mnt/USB/DATA" May 04 16:55:23 volumio volumio[9401]: /bin/mkdir: cannot create directory ‘/mnt/USB/DATA’: File exists May 04 16:55:23 volumio sudo[13265]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sdc1 /mnt/USB/DATA -o noatime,dmask=0000,fmask=0000,iocharset=utf8 May 04 16:55:23 volumio sudo[13265]: pam_unix(sudo:session): session opened for user root by (uid=0) May 04 16:55:24 volumio sudo[13265]: pam_unix(sudo:session): session closed for user root May 04 16:55:24 volumio volumio[9401]: ntfs-3g-mount: failed to access mountpoint /media/DATA: Transport endpoint is not connected May 04 16:55:24 volumio volumio[9401]: error: Failed to mount DATA: Error: Command failed: /usr/bin/sudo /bin/mount "/dev/sdc1" "/mnt/USB/DATA" -o noatime,dmask=0000,fmask=0000,iocharset=utf8 May 04 16:55:24 volumio volumio[9401]: ntfs-3g-mount: failed to access mountpoint /media/DATA: Transport endpoint is not connected May 04 16:55:25 volumio volumio[9401]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 04 16:55:26 volumio volumio[9401]: info: CoreCommandRouter::volumioGetState May 04 16:55:26 volumio volumio[9401]: info: Listing playlists May 04 16:55:26 volumio volumio[9401]: info: Listing playlists May 04 16:55:27 volumio kernel: intel ips 0000:00:1f.6: failed to disable graphics turbo May 04 16:55:28 volumio volumio[9401]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb May 04 16:55:28 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand rescan May 04 16:55:28 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:28 volumio volumio[9401]: info: May 04 16:55:28 volumio volumio[9401]: ---------------------------- MPD announces state update: update May 04 16:55:28 volumio volumio[9401]: info: sendMpdCommand rescan took 2 milliseconds May 04 16:55:28 volumio volumio[9401]: info: ControllerMpd::getState May 04 16:55:28 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:28 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:28 volumio volumio[9401]: info: May 04 16:55:28 volumio volumio[9401]: ---------------------------- MPD announces state update: update May 04 16:55:28 volumio volumio[9401]: info: ControllerMpd::getState May 04 16:55:28 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:28 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:28 volumio volumio[9401]: info: May 04 16:55:28 volumio volumio[9401]: ---------------------------- MPD announces state update: update May 04 16:55:28 volumio volumio[9401]: info: ControllerMpd::getState May 04 16:55:28 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:28 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:28 volumio volumio[9401]: info: May 04 16:55:28 volumio volumio[9401]: ---------------------------- MPD announces state update: update May 04 16:55:28 volumio volumio[9401]: info: ControllerMpd::getState May 04 16:55:28 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:28 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:28 volumio volumio[9401]: info: May 04 16:55:28 volumio volumio[9401]: ---------------------------- MPD announces state update: update May 04 16:55:28 volumio volumio[9401]: info: ControllerMpd::getState May 04 16:55:28 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:28 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:28 volumio volumio[9401]: info: May 04 16:55:28 volumio volumio[9401]: ---------------------------- MPD announces state update: update May 04 16:55:28 volumio volumio[9401]: info: ControllerMpd::getState May 04 16:55:28 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand status May 04 16:55:28 volumio volumio[9401]: info: sendMpdCommand status took 6 milliseconds May 04 16:55:28 volumio volumio[9401]: info: sendMpdCommand status took 5 milliseconds May 04 16:55:28 volumio volumio[9401]: info: sendMpdCommand status took 6 milliseconds May 04 16:55:28 volumio volumio[9401]: info: sendMpdCommand status took 5 milliseconds May 04 16:55:28 volumio volumio[9401]: info: sendMpdCommand status took 4 milliseconds May 04 16:55:28 volumio volumio[9401]: info: sendMpdCommand status took 3 milliseconds May 04 16:55:28 volumio volumio[9401]: info: sendMpdCommand status took 4 milliseconds May 04 16:55:28 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:28 volumio volumio[9401]: info: Command Router : Notfying DB Updatefalse May 04 16:55:28 volumio volumio[9401]: info: CoreCommandRouter::Close All Modals sent May 04 16:55:28 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:28 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 16:55:28 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:28 volumio volumio[9401]: info: Command Router : Notfying DB Updatefalse May 04 16:55:28 volumio volumio[9401]: info: CoreCommandRouter::Close All Modals sent May 04 16:55:28 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:28 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 16:55:28 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:28 volumio volumio[9401]: info: Command Router : Notfying DB Updatefalse May 04 16:55:28 volumio volumio[9401]: info: CoreCommandRouter::Close All Modals sent May 04 16:55:28 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:28 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 16:55:28 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:28 volumio volumio[9401]: info: Command Router : Notfying DB Updatefalse May 04 16:55:28 volumio volumio[9401]: info: CoreCommandRouter::Close All Modals sent May 04 16:55:28 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:28 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 16:55:28 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:28 volumio volumio[9401]: info: Command Router : Notfying DB Updatefalse May 04 16:55:28 volumio volumio[9401]: info: CoreCommandRouter::Close All Modals sent May 04 16:55:28 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:28 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 16:55:28 volumio volumio[9401]: info: sendMpdCommand status took 353 milliseconds May 04 16:55:28 volumio volumio[9401]: info: sendMpdCommand status took 352 milliseconds May 04 16:55:28 volumio volumio[9401]: info: sendMpdCommand playlistinfo took 224 milliseconds May 04 16:55:28 volumio volumio[9401]: info: sendMpdCommand playlistinfo took 93 milliseconds May 04 16:55:28 volumio volumio[9401]: info: sendMpdCommand playlistinfo took 45 milliseconds May 04 16:55:28 volumio volumio[9401]: info: sendMpdCommand playlistinfo took 31 milliseconds May 04 16:55:28 volumio volumio[9401]: info: sendMpdCommand playlistinfo took 17 milliseconds May 04 16:55:28 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:28 volumio volumio[9401]: info: Command Router : Notfying DB Updatefalse May 04 16:55:28 volumio volumio[9401]: info: CoreCommandRouter::Close All Modals sent May 04 16:55:28 volumio volumio[9401]: verbose: ControllerMpd::parseState May 04 16:55:28 volumio volumio[9401]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 04 16:55:28 volumio volumio[9401]: verbose: ControllerMpd::parseTrackInfo May 04 16:55:28 volumio volumio[9401]: verbose: ControllerMpd::parseTrackInfo May 04 16:55:28 volumio volumio[9401]: verbose: ControllerMpd::parseTrackInfo May 04 16:55:28 volumio volumio[9401]: verbose: ControllerMpd::parseTrackInfo May 04 16:55:28 volumio volumio[9401]: verbose: ControllerMpd::parseTrackInfo May 04 16:55:28 volumio volumio[9401]: info: ControllerMpd::pushState May 04 16:55:28 volumio volumio[9401]: info: CoreCommandRouter::servicePushState May 04 16:55:28 volumio volumio[9401]: info: CorePlayQueue::getTrack 0 May 04 16:55:28 volumio volumio[9401]: verbose: STATE SERVICE {"status":"play","position":0,"seek":878983,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grover Washington Jr. - In The Name Of Love","artist":"/SwissJazz_Room1","album":null,"uri":"https://stream.srg-ssr.ch/m/rsj/mp3_128","trackType":""} May 04 16:55:28 volumio volumio[9401]: verbose: CURRENT POSITION 0 May 04 16:55:28 volumio volumio[9401]: info: CoreStateMachine::syncState stateService play May 04 16:55:28 volumio volumio[9401]: info: CoreStateMachine::syncState currentStatus play May 04 16:55:28 volumio volumio[9401]: info: Received an update from plugin. extracting info from payload May 04 16:55:28 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:28 volumio volumio[9401]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 04 16:55:28 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:28 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:28 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:28 volumio volumio[9401]: info: ControllerMpd::pushState May 04 16:55:28 volumio volumio[9401]: info: CoreCommandRouter::servicePushState May 04 16:55:28 volumio volumio[9401]: info: CorePlayQueue::getTrack 0 May 04 16:55:28 volumio volumio[9401]: verbose: STATE SERVICE {"status":"play","position":0,"seek":878983,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grover Washington Jr. - In The Name Of Love","artist":"/SwissJazz_Room1","album":null,"uri":"https://stream.srg-ssr.ch/m/rsj/mp3_128","trackType":""} May 04 16:55:28 volumio volumio[9401]: verbose: CURRENT POSITION 0 May 04 16:55:28 volumio volumio[9401]: info: CoreStateMachine::syncState stateService play May 04 16:55:28 volumio volumio[9401]: info: CoreStateMachine::syncState currentStatus play May 04 16:55:28 volumio volumio[9401]: info: Received an update from plugin. extracting info from payload May 04 16:55:28 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:28 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:28 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:28 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:28 volumio volumio[9401]: info: ControllerMpd::pushState May 04 16:55:28 volumio volumio[9401]: info: CoreCommandRouter::servicePushState May 04 16:55:28 volumio volumio[9401]: info: CorePlayQueue::getTrack 0 May 04 16:55:28 volumio volumio[9401]: verbose: STATE SERVICE {"status":"play","position":0,"seek":878983,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grover Washington Jr. - In The Name Of Love","artist":"/SwissJazz_Room1","album":null,"uri":"https://stream.srg-ssr.ch/m/rsj/mp3_128","trackType":""} May 04 16:55:28 volumio volumio[9401]: verbose: CURRENT POSITION 0 May 04 16:55:28 volumio volumio[9401]: info: CoreStateMachine::syncState stateService play May 04 16:55:28 volumio volumio[9401]: info: CoreStateMachine::syncState currentStatus play May 04 16:55:28 volumio volumio[9401]: info: Received an update from plugin. extracting info from payload May 04 16:55:28 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:28 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:28 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:28 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:28 volumio volumio[9401]: info: ControllerMpd::pushState May 04 16:55:28 volumio volumio[9401]: info: CoreCommandRouter::servicePushState May 04 16:55:28 volumio volumio[9401]: info: CorePlayQueue::getTrack 0 May 04 16:55:28 volumio volumio[9401]: verbose: STATE SERVICE {"status":"play","position":0,"seek":878983,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grover Washington Jr. - In The Name Of Love","artist":"/SwissJazz_Room1","album":null,"uri":"https://stream.srg-ssr.ch/m/rsj/mp3_128","trackType":""} May 04 16:55:28 volumio volumio[9401]: verbose: CURRENT POSITION 0 May 04 16:55:28 volumio volumio[9401]: info: CoreStateMachine::syncState stateService play May 04 16:55:28 volumio volumio[9401]: info: CoreStateMachine::syncState currentStatus play May 04 16:55:28 volumio volumio[9401]: info: Received an update from plugin. extracting info from payload May 04 16:55:28 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:28 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:28 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:28 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:28 volumio volumio[9401]: info: ControllerMpd::pushState May 04 16:55:28 volumio volumio[9401]: info: CoreCommandRouter::servicePushState May 04 16:55:28 volumio volumio[9401]: info: CorePlayQueue::getTrack 0 May 04 16:55:28 volumio volumio[9401]: verbose: STATE SERVICE {"status":"play","position":0,"seek":878983,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grover Washington Jr. - In The Name Of Love","artist":"/SwissJazz_Room1","album":null,"uri":"https://stream.srg-ssr.ch/m/rsj/mp3_128","trackType":""} May 04 16:55:28 volumio volumio[9401]: verbose: CURRENT POSITION 0 May 04 16:55:28 volumio volumio[9401]: info: CoreStateMachine::syncState stateService play May 04 16:55:28 volumio volumio[9401]: info: CoreStateMachine::syncState currentStatus play May 04 16:55:28 volumio volumio[9401]: info: Received an update from plugin. extracting info from payload May 04 16:55:28 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:28 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:28 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:28 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:28 volumio volumio[9401]: info: ------------------------------ 422ms May 04 16:55:28 volumio volumio[9401]: info: ------------------------------ 421ms May 04 16:55:28 volumio volumio[9401]: info: ------------------------------ 420ms May 04 16:55:28 volumio volumio[9401]: info: ------------------------------ 420ms May 04 16:55:28 volumio volumio[9401]: info: ------------------------------ 419ms May 04 16:55:28 volumio volumio[9401]: info: sendMpdCommand playlistinfo took 53 milliseconds May 04 16:55:28 volumio volumio[9401]: verbose: ControllerMpd::parseTrackInfo May 04 16:55:28 volumio volumio[9401]: info: ControllerMpd::pushState May 04 16:55:28 volumio volumio[9401]: info: CoreCommandRouter::servicePushState May 04 16:55:28 volumio volumio[9401]: info: CorePlayQueue::getTrack 0 May 04 16:55:28 volumio volumio[9401]: verbose: STATE SERVICE {"status":"play","position":0,"seek":878983,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Grover Washington Jr. - In The Name Of Love","artist":"/SwissJazz_Room1","album":null,"uri":"https://stream.srg-ssr.ch/m/rsj/mp3_128","trackType":""} May 04 16:55:28 volumio volumio[9401]: verbose: CURRENT POSITION 0 May 04 16:55:28 volumio volumio[9401]: info: CoreStateMachine::syncState stateService play May 04 16:55:28 volumio volumio[9401]: info: CoreStateMachine::syncState currentStatus play May 04 16:55:28 volumio volumio[9401]: info: Received an update from plugin. extracting info from payload May 04 16:55:28 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:28 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:28 volumio volumio[9401]: info: CoreStateMachine::pushState May 04 16:55:28 volumio volumio[9401]: info: CoreCommandRouter::volumioPushState May 04 16:55:28 volumio volumio[9401]: info: ------------------------------ 433ms May 04 16:55:29 volumio volumio[9401]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 04 16:55:30 volumio volumio[9401]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares May 04 16:55:30 volumio volumio[9401]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService May 04 16:55:32 volumio volumio[9401]: info: Executing SMB command: smbclient --no-pass --debuglevel=0 -L iliadbox-Server.local. May 04 16:55:32 volumio kernel: intel ips 0000:00:1f.6: failed to disable graphics turbo May 04 16:55:33 volumio volumio[9401]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 04 16:55:35 volumio volumio[9401]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 04 16:55:35 volumio volumio[9401]: Error: dns service error: unknown May 04 16:55:35 volumio volumio[9401]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30) May 04 16:55:35 volumio volumio[9401]: at SocketWatcher.MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { May 04 16:55:35 volumio volumio[9401]: errorCode: -65537 May 04 16:55:35 volumio volumio[9401]: } May 04 16:55:35 volumio volumio[9401]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 04 16:55:36 volumio sudo[13336]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-04 16:54 May 04 16:55:36 volumio sudo[13336]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="9ab87de061b3649c303da550e73c92d340b0f989" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 24 Apr 2025 10:07:11 AM CEST" VOLUMIO_VERSION="3.804" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="dc77d77f02ef88ea816c3d31de871e8f"