-- Logs begin at Thu 2019-02-14 17:11:58 +07, end at Sun 2025-02-16 19:01:57 +07. -- Feb 16 19:00:01 volumio kernel: sd 0:0:0:0: [sda] Spinning up disk... Feb 16 19:00:01 volumio kernel: .................................................................................................not responding... Feb 16 19:00:01 volumio kernel: sd 0:0:0:0: [sda] Read Capacity(10) failed: Result: hostbyte=0x00 driverbyte=DRIVER_OK Feb 16 19:00:01 volumio kernel: sd 0:0:0:0: [sda] Sense Key : 0x2 [current] Feb 16 19:00:01 volumio kernel: sd 0:0:0:0: [sda] ASC=0x4 ASCQ=0x1 Feb 16 19:00:01 volumio kernel: sd 0:0:0:0: [sda] 0 512-byte logical blocks: (0 B/0 B) Feb 16 19:00:01 volumio kernel: sd 0:0:0:0: [sda] 0-byte physical blocks Feb 16 19:00:01 volumio kernel: sd 0:0:0:0: [sda] Test WP failed, assume Write Enabled Feb 16 19:00:01 volumio kernel: sd 0:0:0:0: [sda] Asking for cache data failed Feb 16 19:00:01 volumio kernel: sd 0:0:0:0: [sda] Assuming drive cache: write through Feb 16 19:00:01 volumio kernel: sd 0:0:0:0: [sda] Attached SCSI disk Feb 16 19:00:01 volumio systemd[1]: systemd-journald.service: Main process exited, code=killed, status=6/ABRT Feb 16 19:00:01 volumio systemd[1]: systemd-journald.service: Failed with result 'watchdog'. Feb 16 19:00:01 volumio systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. Feb 16 19:00:01 volumio systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Feb 16 19:00:01 volumio systemd[1]: systemd-journal-flush.service: Succeeded. Feb 16 19:00:01 volumio systemd[1]: Stopped Flush Journal to Persistent Storage. Feb 16 19:00:01 volumio systemd[1]: Stopping Flush Journal to Persistent Storage... Feb 16 19:00:01 volumio systemd[1]: Stopped Journal Service. Feb 16 19:00:01 volumio kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0 Feb 16 19:00:01 volumio systemd[1]: Starting Journal Service... Feb 16 19:00:01 volumio systemd-journald[3752]: Journal started Feb 16 19:00:01 volumio systemd-journald[3752]: Runtime journal (/run/log/journal/a89b7be63bc86b985c184d84675fe488) is 11.2M, max 30.0M, 18.7M free. Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:01 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 2ms Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand status took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":89702,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:01 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:01 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 27ms Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:01 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 2ms Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand status took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 18:59:02 volumio systemd-udevd[358]: 0:0:0:0: Worker [2708] processing SEQNUM=2531 is taking a long time Feb 16 18:58:06 volumio wpa_supplicant[922]: RRM: Ignoring radio measurement request: Not RRM network Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":92396,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:01 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:01 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 22ms Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:01 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 2ms Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand status took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":94816,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:01 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 18:59:45 volumio systemd[1]: systemd-journald.service: Watchdog timeout (limit 3min)! Feb 16 18:58:12 volumio wpa_supplicant[922]: RRM: Ignoring radio measurement request: Not RRM network Feb 16 19:00:01 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 20ms Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:01 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 5ms Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand status took 3 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":96858,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:01 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:01 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 26ms Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:01 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:01 volumio systemd[1]: Started Journal Service. Feb 16 18:59:45 volumio systemd[1]: systemd-journald.service: Killing process 334 (systemd-journal) with signal SIGABRT. Feb 16 18:58:18 volumio wpa_supplicant[922]: RRM: Ignoring radio measurement request: Not RRM network Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 2ms Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand status took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":99359,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:01 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:01 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 21ms Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:01 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 2ms Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand status took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 0 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio systemd[1]: Starting Flush Journal to Persistent Storage... Feb 16 18:58:26 volumio wpa_supplicant[922]: RRM: Ignoring radio measurement request: Not RRM network Feb 16 19:00:01 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":101962,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:01 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:01 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 23ms Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:01 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 1ms Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand status took 0 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 0 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":104473,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:01 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:01 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 18:58:33 volumio wpa_supplicant[922]: RRM: Ignoring radio measurement request: Not RRM network Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 21ms Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:01 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 2ms Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand status took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 0 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":106984,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:01 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:01 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 22ms Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:01 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 18:58:41 volumio wpa_supplicant[922]: RRM: Ignoring radio measurement request: Not RRM network Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 2ms Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand status took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":109575,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:01 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:01 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 27ms Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:01 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 5ms Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand status took 2 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 18:58:48 volumio wpa_supplicant[922]: RRM: Ignoring radio measurement request: Not RRM network Feb 16 19:00:01 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":112177,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:01 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:01 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 25ms Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:01 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 1ms Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand status took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 0 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":114506,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:01 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:01 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 18:58:56 volumio wpa_supplicant[922]: RRM: Ignoring radio measurement request: Not RRM network Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 25ms Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:01 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 3ms Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand status took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 0 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":117005,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:01 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:01 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 33ms Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:01 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 18:59:03 volumio wpa_supplicant[922]: RRM: Ignoring radio measurement request: Not RRM network Feb 16 19:00:01 volumio systemd[1]: Started Flush Journal to Persistent Storage. Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 1ms Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand status took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 0 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":119608,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:01 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:01 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 23ms Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:01 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 2ms Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand status took 2 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 18:59:11 volumio wpa_supplicant[922]: RRM: Ignoring radio measurement request: Not RRM network Feb 16 19:00:01 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":122393,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:01 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:01 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 38ms Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:01 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 1ms Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand status took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":124721,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:01 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:01 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 18:59:18 volumio wpa_supplicant[922]: RRM: Ignoring radio measurement request: Not RRM network Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 25ms Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:01 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 7ms Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand status took 7 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":127415,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:01 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:01 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 38ms Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:01 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 18:59:26 volumio wpa_supplicant[922]: RRM: Ignoring radio measurement request: Not RRM network Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 1ms Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand status took 0 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 0 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":129275,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:01 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:01 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 19ms Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:01 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 2ms Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand status took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 18:59:32 volumio wpa_supplicant[922]: RRM: Ignoring radio measurement request: Not RRM network Feb 16 19:00:01 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":131962,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:01 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:01 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 27ms Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:01 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 5ms Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand status took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 0 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":134382,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:01 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:01 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 18:59:41 volumio wpa_supplicant[922]: RRM: Ignoring radio measurement request: Not RRM network Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 30ms Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:01 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 2ms Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand status took 2 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":136893,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:01 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:01 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 24ms Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:01 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 18:59:48 volumio wpa_supplicant[922]: RRM: Ignoring radio measurement request: Not RRM network Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 1ms Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand status took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":139484,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:01 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:01 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 27ms Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:01 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 1ms Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand status took 2 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 18:59:56 volumio wpa_supplicant[922]: RRM: Ignoring radio measurement request: Not RRM network Feb 16 19:00:01 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":142372,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:01 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:01 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 20ms Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:01 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 1ms Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand status took 2 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":144597,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:01 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:01 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 24ms Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:01 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 2ms Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand status took 2 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":147108,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:01 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:01 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 35ms Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:01 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 1ms Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand status took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":149699,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:01 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:01 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 21ms Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:01 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 2ms Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand status took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 0 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":152496,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:01 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:01 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 25ms Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:01 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 2ms Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand status took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":154721,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:01 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:01 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 19ms Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:01 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 6ms Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand status took 2 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":157415,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:01 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:01 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 23ms Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:01 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 2ms Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand status took 2 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":159732,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:01 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:01 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 20ms Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:01 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 2ms Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand status took 2 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":161968,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:01 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:01 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 29ms Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:01 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 1ms Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand status took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":164378,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:01 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:01 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 19ms Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:01 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 1ms Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand status took 0 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":166889,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:01 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:01 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 21ms Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:01 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 1ms Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand status took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":169492,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:01 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:01 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 20ms Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:01 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 1ms Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand status took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":171991,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:01 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:01 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 18ms Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:01 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 1ms Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand status took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":174502,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:01 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:01 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 24ms Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:01 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 2ms Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand status took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 3 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":177105,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:01 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:01 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 30ms Feb 16 19:00:01 volumio volumio[1023]: info: peppy_screensaver: Start PeppyMeter Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:01 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 1ms Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand status took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":179616,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:01 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:01 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 18ms Feb 16 19:00:01 volumio volumio[1023]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 7 Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioGetState Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:01 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 2ms Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand status took 2 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":182310,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:01 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:01 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 22ms Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:01 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 3ms Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand status took 2 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":184809,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:01 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:01 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 30ms Feb 16 19:00:01 volumio volumio[1023]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 8 Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioGetState Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:01 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 2ms Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand status took 2 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":187137,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:01 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:01 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 23ms Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:01 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 1ms Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand status took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":189740,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:01 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:01 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 20ms Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:01 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 2ms Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand status took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":192434,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:01 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:01 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 26ms Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:01 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 2ms Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand status took 2 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":194282,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:01 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:01 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 22ms Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:01 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 2ms Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand status took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":196886,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:01 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:01 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 46ms Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:01 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 1ms Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand status took 0 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 0 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":199397,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:01 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:01 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 21ms Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:01 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 3ms Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand status took 2 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":202182,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:01 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:01 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 21ms Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:01 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 1ms Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand status took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":204408,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:01 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:01 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 20ms Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:01 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:01 volumio volumio[1023]: info: Feb 16 19:00:01 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 3ms Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand status took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:01 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:00:01 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:01 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":206919,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:01 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:01 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:01 volumio volumio[1023]: info: ------------------------------ 28ms Feb 16 19:00:02 volumio wpa_supplicant[922]: RRM: Ignoring radio measurement request: Not RRM network Feb 16 19:00:03 volumio volumio[1023]: info: Feb 16 19:00:03 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:03 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:03 volumio volumio[1023]: info: Feb 16 19:00:03 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:03 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:03 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:03 volumio volumio[1023]: info: ------------------------------ 5ms Feb 16 19:00:03 volumio volumio[1023]: info: sendMpdCommand status took 4 milliseconds Feb 16 19:00:03 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:03 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:03 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:00:03 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:03 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:03 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:03 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:03 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":209521,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:03 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:03 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:03 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:03 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:03 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:03 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:03 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:03 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:03 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:03 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:03 volumio volumio[1023]: info: ------------------------------ 34ms Feb 16 19:00:06 volumio volumio[1023]: info: Feb 16 19:00:06 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:06 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:06 volumio volumio[1023]: info: Feb 16 19:00:06 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:06 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:06 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:06 volumio volumio[1023]: info: ------------------------------ 5ms Feb 16 19:00:06 volumio volumio[1023]: info: sendMpdCommand status took 2 milliseconds Feb 16 19:00:06 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:06 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:06 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:00:06 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:06 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:06 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:06 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:06 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":212398,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:06 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:06 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:06 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:06 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:06 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:06 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:06 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:06 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:06 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:06 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:06 volumio volumio[1023]: info: ------------------------------ 21ms Feb 16 19:00:08 volumio volumio[1023]: info: Feb 16 19:00:08 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:08 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:08 volumio volumio[1023]: info: Feb 16 19:00:08 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:08 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:08 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:08 volumio volumio[1023]: info: ------------------------------ 2ms Feb 16 19:00:08 volumio volumio[1023]: info: sendMpdCommand status took 2 milliseconds Feb 16 19:00:08 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:08 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:08 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:00:08 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:08 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:08 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:08 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:08 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":214532,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:08 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:08 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:08 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:08 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:08 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:08 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:08 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:08 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:08 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:08 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:08 volumio volumio[1023]: info: ------------------------------ 21ms Feb 16 19:00:11 volumio volumio[1023]: info: Feb 16 19:00:11 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:11 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:11 volumio volumio[1023]: info: Feb 16 19:00:11 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:11 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:11 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:11 volumio volumio[1023]: info: ------------------------------ 2ms Feb 16 19:00:11 volumio volumio[1023]: info: sendMpdCommand status took 3 milliseconds Feb 16 19:00:11 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:11 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:11 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:00:11 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:11 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:11 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:11 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:11 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":217134,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:11 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:11 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:11 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:11 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:11 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:11 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:11 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:11 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:11 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:11 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:11 volumio volumio[1023]: info: ------------------------------ 25ms Feb 16 19:00:11 volumio wpa_supplicant[922]: RRM: Ignoring radio measurement request: Not RRM network Feb 16 19:00:13 volumio volumio[1023]: info: Feb 16 19:00:13 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:13 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:13 volumio volumio[1023]: info: Feb 16 19:00:13 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:13 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:13 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:13 volumio volumio[1023]: info: ------------------------------ 2ms Feb 16 19:00:13 volumio volumio[1023]: info: sendMpdCommand status took 1 milliseconds Feb 16 19:00:13 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:13 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:13 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 0 milliseconds Feb 16 19:00:13 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:13 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:13 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:13 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:13 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":219645,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:13 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:13 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:13 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:13 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:13 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:13 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:13 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:13 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:13 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:13 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:13 volumio volumio[1023]: info: ------------------------------ 35ms Feb 16 19:00:16 volumio volumio[1023]: info: Feb 16 19:00:16 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:16 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:16 volumio volumio[1023]: info: Feb 16 19:00:16 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:16 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:16 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:16 volumio volumio[1023]: info: ------------------------------ 3ms Feb 16 19:00:16 volumio volumio[1023]: info: sendMpdCommand status took 2 milliseconds Feb 16 19:00:16 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:16 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:16 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:00:16 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:16 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:16 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:16 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:16 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":222431,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:16 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:16 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:16 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:16 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:16 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:16 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:16 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:16 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:16 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:16 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:16 volumio volumio[1023]: info: ------------------------------ 31ms Feb 16 19:00:18 volumio wpa_supplicant[922]: RRM: Ignoring radio measurement request: Not RRM network Feb 16 19:00:18 volumio volumio[1023]: info: Feb 16 19:00:18 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:18 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:18 volumio volumio[1023]: info: Feb 16 19:00:18 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:18 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:18 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:18 volumio volumio[1023]: info: ------------------------------ 3ms Feb 16 19:00:18 volumio volumio[1023]: info: sendMpdCommand status took 2 milliseconds Feb 16 19:00:18 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:18 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:18 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:00:18 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:18 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:18 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:18 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:18 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":224839,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:18 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:18 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:18 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:18 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:18 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:18 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:18 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:18 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:18 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:18 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:18 volumio volumio[1023]: info: ------------------------------ 25ms Feb 16 19:00:20 volumio volumio[1023]: info: Feb 16 19:00:20 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:20 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:20 volumio volumio[1023]: info: Feb 16 19:00:20 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:20 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:20 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:20 volumio volumio[1023]: info: ------------------------------ 3ms Feb 16 19:00:20 volumio volumio[1023]: info: sendMpdCommand status took 2 milliseconds Feb 16 19:00:20 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:20 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:20 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 0 milliseconds Feb 16 19:00:20 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:20 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:20 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:20 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:20 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":226984,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:20 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:20 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:20 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:20 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:20 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:20 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:20 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:20 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:20 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:20 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:20 volumio volumio[1023]: info: ------------------------------ 25ms Feb 16 19:00:23 volumio volumio[1023]: info: Feb 16 19:00:23 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:23 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:23 volumio volumio[1023]: info: Feb 16 19:00:23 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:23 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:23 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:23 volumio volumio[1023]: info: ------------------------------ 1ms Feb 16 19:00:23 volumio volumio[1023]: info: sendMpdCommand status took 1 milliseconds Feb 16 19:00:23 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:23 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:23 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:00:23 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:23 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:23 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:23 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:23 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":229394,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:23 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:23 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:23 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:23 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:23 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:23 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:23 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:23 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:23 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:23 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:23 volumio volumio[1023]: info: ------------------------------ 20ms Feb 16 19:00:25 volumio volumio[1023]: info: Feb 16 19:00:25 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:25 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:25 volumio volumio[1023]: info: Feb 16 19:00:25 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:25 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:25 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:25 volumio volumio[1023]: info: ------------------------------ 2ms Feb 16 19:00:25 volumio volumio[1023]: info: sendMpdCommand status took 1 milliseconds Feb 16 19:00:25 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:25 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:25 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 0 milliseconds Feb 16 19:00:25 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:25 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:25 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:25 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:25 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":232088,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:25 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:25 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:25 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:25 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:25 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:25 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:25 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:25 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:25 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:25 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:25 volumio volumio[1023]: info: ------------------------------ 27ms Feb 16 19:00:26 volumio wpa_supplicant[922]: RRM: Ignoring radio measurement request: Not RRM network Feb 16 19:00:28 volumio volumio[1023]: info: Feb 16 19:00:28 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:28 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:28 volumio volumio[1023]: info: Feb 16 19:00:28 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:28 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:28 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:28 volumio volumio[1023]: info: ------------------------------ 1ms Feb 16 19:00:28 volumio volumio[1023]: info: sendMpdCommand status took 1 milliseconds Feb 16 19:00:28 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:28 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:28 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:00:28 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:28 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:28 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:28 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:28 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":234507,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:28 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:28 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:28 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:28 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:28 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:28 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:28 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:28 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:28 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:28 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:28 volumio volumio[1023]: info: ------------------------------ 27ms Feb 16 19:00:31 volumio volumio[1023]: info: Feb 16 19:00:31 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:31 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:31 volumio volumio[1023]: info: Feb 16 19:00:31 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:31 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:31 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:31 volumio volumio[1023]: info: ------------------------------ 2ms Feb 16 19:00:31 volumio volumio[1023]: info: sendMpdCommand status took 2 milliseconds Feb 16 19:00:31 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:31 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:31 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:00:31 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:31 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:31 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:31 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:31 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":237201,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:31 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:31 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:31 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:31 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:31 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:31 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:31 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:31 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:31 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:31 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:31 volumio volumio[1023]: info: ------------------------------ 20ms Feb 16 19:00:32 volumio volumio[1023]: info: peppy_screensaver: Start PeppyMeter Feb 16 19:00:33 volumio volumio[1023]: info: Feb 16 19:00:33 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:33 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:33 volumio volumio[1023]: info: Feb 16 19:00:33 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:33 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:33 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:33 volumio volumio[1023]: info: ------------------------------ 1ms Feb 16 19:00:33 volumio volumio[1023]: info: sendMpdCommand status took 1 milliseconds Feb 16 19:00:33 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:33 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:33 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:00:33 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:33 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:33 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:33 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:33 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":239426,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:33 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:33 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:33 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:33 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:33 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:33 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:33 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:33 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:33 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:33 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:33 volumio volumio[1023]: info: ------------------------------ 17ms Feb 16 19:00:33 volumio wpa_supplicant[922]: RRM: Ignoring radio measurement request: Not RRM network Feb 16 19:00:35 volumio volumio[1023]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 7 Feb 16 19:00:35 volumio volumio[1023]: info: CoreCommandRouter::volumioGetState Feb 16 19:00:36 volumio volumio[1023]: info: Feb 16 19:00:36 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:36 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:36 volumio volumio[1023]: info: Feb 16 19:00:36 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:36 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:36 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:36 volumio volumio[1023]: info: ------------------------------ 1ms Feb 16 19:00:36 volumio volumio[1023]: info: sendMpdCommand status took 2 milliseconds Feb 16 19:00:36 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:36 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:36 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 0 milliseconds Feb 16 19:00:36 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:36 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:36 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:36 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:36 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":242303,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:36 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:36 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:36 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:36 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:36 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:36 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:36 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:36 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:36 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:36 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:36 volumio volumio[1023]: info: ------------------------------ 24ms Feb 16 19:00:38 volumio volumio[1023]: info: Feb 16 19:00:38 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:38 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:38 volumio volumio[1023]: info: Feb 16 19:00:38 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:38 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:38 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:38 volumio volumio[1023]: info: ------------------------------ 6ms Feb 16 19:00:38 volumio volumio[1023]: info: sendMpdCommand status took 3 milliseconds Feb 16 19:00:38 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:38 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:38 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:00:38 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:38 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:38 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:38 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:38 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":244540,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:38 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:38 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:38 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:38 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:38 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:38 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:38 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:38 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:38 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:38 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:38 volumio volumio[1023]: info: ------------------------------ 27ms Feb 16 19:00:39 volumio volumio[1023]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 8 Feb 16 19:00:39 volumio volumio[1023]: info: CoreCommandRouter::volumioGetState Feb 16 19:00:41 volumio volumio[1023]: info: Feb 16 19:00:41 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:41 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:41 volumio volumio[1023]: info: Feb 16 19:00:41 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:41 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:41 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:41 volumio volumio[1023]: info: ------------------------------ 2ms Feb 16 19:00:41 volumio volumio[1023]: info: sendMpdCommand status took 2 milliseconds Feb 16 19:00:41 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:41 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:41 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:00:41 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:41 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:41 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:41 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:41 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":247131,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:41 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:41 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:41 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:41 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:41 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:41 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:41 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:41 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:41 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:41 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:41 volumio volumio[1023]: info: ------------------------------ 24ms Feb 16 19:00:41 volumio wpa_supplicant[922]: RRM: Ignoring radio measurement request: Not RRM network Feb 16 19:00:43 volumio volumio[1023]: info: Feb 16 19:00:43 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:43 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:43 volumio volumio[1023]: info: Feb 16 19:00:43 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:43 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:43 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:43 volumio volumio[1023]: info: ------------------------------ 1ms Feb 16 19:00:43 volumio volumio[1023]: info: sendMpdCommand status took 3 milliseconds Feb 16 19:00:43 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:43 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:43 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 3 milliseconds Feb 16 19:00:43 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:43 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:43 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:43 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:43 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":249642,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:43 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:43 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:43 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:43 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:43 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:43 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:43 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:43 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:43 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:43 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:43 volumio volumio[1023]: info: ------------------------------ 35ms Feb 16 19:00:46 volumio volumio[1023]: info: Feb 16 19:00:46 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:46 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:46 volumio volumio[1023]: info: Feb 16 19:00:46 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:46 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:46 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:46 volumio volumio[1023]: info: ------------------------------ 2ms Feb 16 19:00:46 volumio volumio[1023]: info: sendMpdCommand status took 2 milliseconds Feb 16 19:00:46 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:46 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:46 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:00:46 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:46 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:46 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:46 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:46 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":252427,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:46 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:46 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:46 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:46 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:46 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:46 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:46 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:46 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:46 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:46 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:46 volumio volumio[1023]: info: ------------------------------ 23ms Feb 16 19:00:48 volumio wpa_supplicant[922]: RRM: Ignoring radio measurement request: Not RRM network Feb 16 19:00:48 volumio volumio[1023]: info: Feb 16 19:00:48 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:48 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:48 volumio volumio[1023]: info: Feb 16 19:00:48 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:48 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:48 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:48 volumio volumio[1023]: info: ------------------------------ 4ms Feb 16 19:00:48 volumio volumio[1023]: info: sendMpdCommand status took 3 milliseconds Feb 16 19:00:48 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:48 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:48 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 0 milliseconds Feb 16 19:00:48 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:48 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:48 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:48 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:48 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":254755,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:48 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:48 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:48 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:48 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:48 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:48 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:48 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:48 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:48 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:48 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:48 volumio volumio[1023]: info: ------------------------------ 31ms Feb 16 19:00:50 volumio volumio[1023]: info: peppy_screensaver: Start PeppyMeter Feb 16 19:00:51 volumio volumio[1023]: info: Feb 16 19:00:51 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:51 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:51 volumio volumio[1023]: info: Feb 16 19:00:51 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:51 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:51 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:51 volumio volumio[1023]: info: ------------------------------ 2ms Feb 16 19:00:51 volumio volumio[1023]: info: sendMpdCommand status took 1 milliseconds Feb 16 19:00:51 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:51 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:51 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 16 19:00:51 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:51 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:51 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:51 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:51 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":257164,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:51 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:51 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:51 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:51 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:51 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:51 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:51 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:51 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:51 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:51 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:51 volumio volumio[1023]: info: ------------------------------ 22ms Feb 16 19:00:53 volumio volumio[1023]: info: Feb 16 19:00:53 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:53 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:53 volumio volumio[1023]: info: Feb 16 19:00:53 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:53 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:53 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:53 volumio volumio[1023]: info: ------------------------------ 1ms Feb 16 19:00:53 volumio volumio[1023]: info: sendMpdCommand status took 2 milliseconds Feb 16 19:00:53 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:53 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:53 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 0 milliseconds Feb 16 19:00:53 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:53 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:53 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:53 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:53 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":259297,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:53 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:53 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:53 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:53 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:53 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:53 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:53 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:53 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:53 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:53 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:53 volumio volumio[1023]: info: ------------------------------ 19ms Feb 16 19:00:55 volumio volumio[1023]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 7 Feb 16 19:00:55 volumio volumio[1023]: info: CoreCommandRouter::volumioGetState Feb 16 19:00:55 volumio volumio[1023]: info: Feb 16 19:00:55 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:55 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:55 volumio volumio[1023]: info: Feb 16 19:00:55 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:55 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:55 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:55 volumio volumio[1023]: info: ------------------------------ 4ms Feb 16 19:00:55 volumio volumio[1023]: info: sendMpdCommand status took 4 milliseconds Feb 16 19:00:55 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:55 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:55 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:00:55 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:55 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:55 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:55 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:55 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":261996,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:55 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:55 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:55 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:55 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:55 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:55 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:55 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:55 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:55 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:55 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:55 volumio volumio[1023]: info: ------------------------------ 26ms Feb 16 19:00:56 volumio wpa_supplicant[922]: RRM: Ignoring radio measurement request: Not RRM network Feb 16 19:00:58 volumio volumio[1023]: info: Feb 16 19:00:58 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:00:58 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:00:58 volumio volumio[1023]: info: Feb 16 19:00:58 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:00:58 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:00:58 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:00:58 volumio volumio[1023]: info: ------------------------------ 2ms Feb 16 19:00:58 volumio volumio[1023]: info: sendMpdCommand status took 1 milliseconds Feb 16 19:00:58 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:00:58 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:00:58 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 16 19:00:58 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:00:58 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:00:58 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:00:58 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:58 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":264416,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:00:58 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:00:58 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:00:58 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:00:58 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:00:58 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:58 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:00:58 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:00:58 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:58 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:00:58 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:00:58 volumio volumio[1023]: info: ------------------------------ 28ms Feb 16 19:00:59 volumio volumio[1023]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 8 Feb 16 19:01:00 volumio volumio[1023]: info: peppy_screensaver: Start PeppyMeter Feb 16 19:01:00 volumio volumio[1023]: info: Feb 16 19:01:00 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:01:00 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:01:00 volumio volumio[1023]: info: Feb 16 19:01:00 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:01:00 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:01:00 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:01:00 volumio volumio[1023]: info: ------------------------------ 2ms Feb 16 19:01:00 volumio volumio[1023]: info: sendMpdCommand status took 1 milliseconds Feb 16 19:01:00 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:01:00 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:01:00 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 0 milliseconds Feb 16 19:01:00 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:01:00 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:01:00 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:01:00 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:01:00 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":266915,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:01:00 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:01:00 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:01:00 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:01:00 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:01:00 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:01:00 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:01:00 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:01:00 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:01:00 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:01:00 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:01:00 volumio volumio[1023]: info: ------------------------------ 18ms Feb 16 19:01:03 volumio volumio[1023]: info: Feb 16 19:01:03 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:01:03 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:01:03 volumio volumio[1023]: info: Feb 16 19:01:03 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:01:03 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:01:03 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:01:03 volumio volumio[1023]: info: ------------------------------ 2ms Feb 16 19:01:03 volumio volumio[1023]: info: sendMpdCommand status took 1 milliseconds Feb 16 19:01:03 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:01:03 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:01:03 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:01:03 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:01:03 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:01:03 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:01:03 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:01:03 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":269518,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:01:03 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:01:03 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:01:03 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:01:03 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:01:03 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:01:03 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:01:03 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:01:03 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:01:03 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:01:03 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:01:03 volumio volumio[1023]: info: ------------------------------ 23ms Feb 16 19:01:03 volumio wpa_supplicant[922]: RRM: Ignoring radio measurement request: Not RRM network Feb 16 19:01:05 volumio volumio[1023]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 8 Feb 16 19:01:05 volumio volumio[1023]: info: CoreCommandRouter::volumioGetState Feb 16 19:01:06 volumio volumio[1023]: info: Feb 16 19:01:06 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:01:06 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:01:06 volumio volumio[1023]: info: Feb 16 19:01:06 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:01:06 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:01:06 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:01:06 volumio volumio[1023]: info: ------------------------------ 2ms Feb 16 19:01:06 volumio volumio[1023]: info: sendMpdCommand status took 1 milliseconds Feb 16 19:01:06 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:01:06 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:01:06 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:01:06 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:01:06 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:01:06 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:01:06 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:01:06 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":272303,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:01:06 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:01:06 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:01:06 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:01:06 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:01:06 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:01:06 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:01:06 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:01:06 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:01:06 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:01:06 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:01:06 volumio volumio[1023]: info: ------------------------------ 22ms Feb 16 19:01:08 volumio volumio[1023]: info: Feb 16 19:01:08 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:01:08 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:01:08 volumio volumio[1023]: info: Feb 16 19:01:08 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:01:08 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:01:08 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:01:08 volumio volumio[1023]: info: ------------------------------ 2ms Feb 16 19:01:08 volumio volumio[1023]: info: sendMpdCommand status took 1 milliseconds Feb 16 19:01:08 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:01:08 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:01:08 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:01:08 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:01:08 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:01:08 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:01:08 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:01:08 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":274445,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:01:08 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:01:08 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:01:08 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:01:08 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:01:08 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:01:08 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:01:08 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:01:08 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:01:08 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:01:08 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:01:08 volumio volumio[1023]: info: ------------------------------ 19ms Feb 16 19:01:09 volumio volumio[1023]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 9 Feb 16 19:01:09 volumio volumio[1023]: info: CoreCommandRouter::volumioGetState Feb 16 19:01:11 volumio volumio[1023]: info: Feb 16 19:01:11 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:01:11 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:01:11 volumio volumio[1023]: info: Feb 16 19:01:11 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:01:11 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:01:11 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:01:11 volumio volumio[1023]: info: ------------------------------ 2ms Feb 16 19:01:11 volumio volumio[1023]: info: sendMpdCommand status took 1 milliseconds Feb 16 19:01:11 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:01:11 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:01:11 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 0 milliseconds Feb 16 19:01:11 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:01:11 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:01:11 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:01:11 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:01:11 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":277231,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:01:11 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:01:11 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:01:11 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:01:11 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:01:11 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:01:11 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:01:11 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:01:11 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:01:11 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:01:11 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:01:11 volumio volumio[1023]: info: ------------------------------ 27ms Feb 16 19:01:11 volumio wpa_supplicant[922]: RRM: Ignoring radio measurement request: Not RRM network Feb 16 19:01:12 volumio volumio[1023]: info: peppy_screensaver: Start PeppyMeter Feb 16 19:01:13 volumio volumio[1023]: info: Feb 16 19:01:13 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:01:13 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:01:13 volumio volumio[1023]: info: Feb 16 19:01:13 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:01:13 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:01:13 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:01:13 volumio volumio[1023]: info: ------------------------------ 1ms Feb 16 19:01:13 volumio volumio[1023]: info: sendMpdCommand status took 2 milliseconds Feb 16 19:01:13 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:01:13 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:01:13 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:01:13 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:01:13 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:01:13 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:01:13 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:01:13 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":279547,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:01:13 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:01:13 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:01:13 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:01:13 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:01:13 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:01:13 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:01:13 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:01:13 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:01:13 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:01:13 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:01:13 volumio volumio[1023]: info: ------------------------------ 19ms Feb 16 19:01:15 volumio volumio[1023]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 8 Feb 16 19:01:15 volumio volumio[1023]: info: CoreCommandRouter::volumioGetState Feb 16 19:01:16 volumio volumio[1023]: info: Feb 16 19:01:16 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:01:16 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:01:16 volumio volumio[1023]: info: Feb 16 19:01:16 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:01:16 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:01:16 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:01:16 volumio volumio[1023]: info: ------------------------------ 3ms Feb 16 19:01:16 volumio volumio[1023]: info: sendMpdCommand status took 3 milliseconds Feb 16 19:01:16 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:01:16 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:01:16 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 4 milliseconds Feb 16 19:01:16 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:01:16 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:01:16 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:01:16 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:01:16 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":282435,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:01:16 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:01:16 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:01:16 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:01:16 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:01:16 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:01:16 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:01:16 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:01:16 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:01:16 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:01:16 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:01:16 volumio volumio[1023]: info: ------------------------------ 28ms Feb 16 19:01:18 volumio volumio[1023]: info: Feb 16 19:01:18 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:01:18 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:01:18 volumio volumio[1023]: info: Feb 16 19:01:18 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:01:18 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:01:18 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:01:18 volumio volumio[1023]: info: ------------------------------ 1ms Feb 16 19:01:18 volumio volumio[1023]: info: sendMpdCommand status took 2 milliseconds Feb 16 19:01:18 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:01:18 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:01:18 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 0 milliseconds Feb 16 19:01:18 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:01:18 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:01:18 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:01:18 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:01:18 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":284661,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:01:18 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:01:18 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:01:18 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:01:18 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:01:18 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:01:18 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:01:18 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:01:18 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:01:18 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:01:18 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:01:18 volumio volumio[1023]: info: ------------------------------ 24ms Feb 16 19:01:18 volumio wpa_supplicant[922]: RRM: Ignoring radio measurement request: Not RRM network Feb 16 19:01:19 volumio volumio[1023]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 9 Feb 16 19:01:19 volumio volumio[1023]: info: CoreCommandRouter::volumioGetState Feb 16 19:01:21 volumio volumio[1023]: info: Feb 16 19:01:21 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:01:21 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:01:21 volumio volumio[1023]: info: Feb 16 19:01:21 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:01:21 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:01:21 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:01:21 volumio volumio[1023]: info: peppy_screensaver: Start PeppyMeter Feb 16 19:01:21 volumio volumio[1023]: info: ------------------------------ 7ms Feb 16 19:01:21 volumio volumio[1023]: info: sendMpdCommand status took 6 milliseconds Feb 16 19:01:21 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:01:21 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:01:21 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:01:21 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:01:21 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:01:21 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:01:21 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:01:21 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":287263,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:01:21 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:01:21 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:01:21 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:01:21 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:01:21 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:01:21 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:01:21 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:01:21 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:01:21 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:01:21 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:01:21 volumio volumio[1023]: info: ------------------------------ 22ms Feb 16 19:01:23 volumio volumio[1023]: info: Feb 16 19:01:23 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:01:23 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:01:23 volumio volumio[1023]: info: Feb 16 19:01:23 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:01:23 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:01:23 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:01:23 volumio volumio[1023]: info: ------------------------------ 2ms Feb 16 19:01:23 volumio volumio[1023]: info: sendMpdCommand status took 2 milliseconds Feb 16 19:01:23 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:01:23 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:01:23 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 16 19:01:23 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:01:23 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:01:23 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:01:23 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:01:23 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":289763,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:01:23 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:01:23 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:01:23 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:01:23 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:01:23 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:01:23 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:01:23 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:01:23 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:01:23 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:01:23 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:01:23 volumio volumio[1023]: info: ------------------------------ 23ms Feb 16 19:01:24 volumio volumio[1023]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 16 19:01:24 volumio volumio[1023]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 16 19:01:24 volumio volumio[1023]: info: Retrieving Cloud Streaming UI Feb 16 19:01:24 volumio volumio[1023]: info: Getting Tidal Cloud Configuration Feb 16 19:01:24 volumio volumio[1023]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 16 19:01:24 volumio volumio[1023]: info: Getting Qobuz Cloud Configuration Feb 16 19:01:24 volumio volumio[1023]: info: Asking plugin for UI Config Feb 16 19:01:24 volumio volumio[1023]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 16 19:01:24 volumio volumio[1023]: info: Getting Spotify Cloud Configuration Feb 16 19:01:24 volumio volumio[1023]: info: Asking plugin for UI Config Feb 16 19:01:24 volumio volumio[1023]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 16 19:01:24 volumio volumio[1023]: info: Saving Spotify Acccount Feb 16 19:01:24 volumio volumio[1023]: info: Got Tidal Cloud Configuration Feb 16 19:01:24 volumio volumio[1023]: info: Got it Feb 16 19:01:24 volumio volumio[1023]: info: Got it Feb 16 19:01:24 volumio volumio[1023]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Feb 16 19:01:24 volumio volumio[1023]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 16 19:01:24 volumio volumio[1023]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Feb 16 19:01:24 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Feb 16 19:01:24 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 16 19:01:24 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 16 19:01:24 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 16 19:01:24 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 16 19:01:24 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 16 19:01:24 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 16 19:01:24 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 16 19:01:24 volumio volumio[1023]: info: CoreCommandRouter::volumioGetBrowseSources Feb 16 19:01:24 volumio volumio[1023]: info: CoreCommandRouter::volumioGetBrowseSources Feb 16 19:01:24 volumio volumio[1023]: info: CoreCommandRouter::volumioGetBrowseSources Feb 16 19:01:25 volumio volumio[1023]: info: Feb 16 19:01:25 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:01:25 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:01:25 volumio volumio[1023]: info: Feb 16 19:01:25 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:01:25 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:01:25 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:01:25 volumio volumio[1023]: info: ------------------------------ 3ms Feb 16 19:01:25 volumio volumio[1023]: info: sendMpdCommand status took 3 milliseconds Feb 16 19:01:25 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:01:25 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:01:25 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:01:25 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:01:25 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:01:25 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:01:25 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:01:25 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":291999,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:01:25 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:01:25 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:01:25 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:01:25 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:01:25 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:01:25 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:01:25 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:01:25 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:01:25 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:01:25 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:01:25 volumio volumio[1023]: info: ------------------------------ 52ms Feb 16 19:01:26 volumio volumio[1023]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 8 Feb 16 19:01:26 volumio volumio[1023]: info: CoreCommandRouter::volumioGetState Feb 16 19:01:26 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 16 19:01:26 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Feb 16 19:01:26 volumio wpa_supplicant[922]: RRM: Ignoring radio measurement request: Not RRM network Feb 16 19:01:28 volumio volumio[1023]: info: Feb 16 19:01:28 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:01:28 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:01:28 volumio volumio[1023]: info: Feb 16 19:01:28 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:01:28 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:01:28 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:01:28 volumio volumio[1023]: info: ------------------------------ 2ms Feb 16 19:01:28 volumio volumio[1023]: info: sendMpdCommand status took 2 milliseconds Feb 16 19:01:28 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:01:28 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:01:28 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:01:28 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:01:28 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:01:28 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:01:28 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:01:28 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":294413,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:01:28 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:01:28 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:01:28 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:01:28 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:01:28 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:01:28 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:01:28 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:01:28 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:01:28 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:01:28 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:01:28 volumio volumio[1023]: info: ------------------------------ 26ms Feb 16 19:01:30 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 16 19:01:30 volumio volumio[1023]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 8 Feb 16 19:01:30 volumio volumio[1023]: info: CoreCommandRouter::volumioGetState Feb 16 19:01:30 volumio volumio[1023]: info: Feb 16 19:01:30 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:01:30 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:01:30 volumio volumio[1023]: info: Feb 16 19:01:30 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:01:30 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:01:30 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:01:30 volumio volumio[1023]: info: ------------------------------ 2ms Feb 16 19:01:30 volumio volumio[1023]: info: sendMpdCommand status took 2 milliseconds Feb 16 19:01:30 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:01:30 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:01:30 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:01:30 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:01:30 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:01:30 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:01:30 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:01:30 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":297015,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:01:30 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:01:30 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:01:30 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:01:30 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:01:30 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:01:30 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:01:30 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:01:30 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:01:30 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:01:30 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:01:30 volumio volumio[1023]: info: ------------------------------ 36ms Feb 16 19:01:33 volumio volumio[1023]: info: Feb 16 19:01:33 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:01:33 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:01:33 volumio volumio[1023]: info: Feb 16 19:01:33 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:01:33 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:01:33 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:01:33 volumio volumio[1023]: info: ------------------------------ 7ms Feb 16 19:01:33 volumio volumio[1023]: info: sendMpdCommand status took 1 milliseconds Feb 16 19:01:33 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:01:33 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:01:33 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 0 milliseconds Feb 16 19:01:33 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:01:33 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:01:33 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:01:33 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:01:33 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":299423,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:01:33 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:01:33 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:01:33 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:01:33 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:01:33 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:01:33 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:01:33 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:01:33 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:01:33 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:01:33 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:01:33 volumio volumio[1023]: info: ------------------------------ 29ms Feb 16 19:01:34 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 16 19:01:35 volumio volumio[1023]: info: peppy_screensaver: Start PeppyMeter Feb 16 19:01:36 volumio volumio[1023]: info: Feb 16 19:01:36 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:01:36 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:01:36 volumio volumio[1023]: info: Feb 16 19:01:36 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:01:36 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:01:36 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:01:36 volumio volumio[1023]: info: ------------------------------ 3ms Feb 16 19:01:36 volumio volumio[1023]: info: sendMpdCommand status took 3 milliseconds Feb 16 19:01:36 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:01:36 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:01:36 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:01:36 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:01:36 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:01:36 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:01:36 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:01:36 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":302208,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:01:36 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:01:36 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:01:36 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:01:36 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:01:36 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:01:36 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:01:36 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:01:36 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:01:36 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:01:36 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:01:36 volumio volumio[1023]: info: ------------------------------ 27ms Feb 16 19:01:38 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 16 19:01:38 volumio volumio[1023]: info: Feb 16 19:01:38 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:01:38 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:01:38 volumio volumio[1023]: info: Feb 16 19:01:38 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:01:38 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:01:38 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:01:38 volumio volumio[1023]: info: ------------------------------ 2ms Feb 16 19:01:38 volumio volumio[1023]: info: sendMpdCommand status took 1 milliseconds Feb 16 19:01:38 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:01:38 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:01:38 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:01:38 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:01:38 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:01:38 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:01:38 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:01:38 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":304445,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:01:38 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:01:38 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:01:38 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:01:38 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:01:38 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:01:38 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:01:38 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:01:38 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:01:38 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:01:38 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:01:38 volumio volumio[1023]: info: ------------------------------ 21ms Feb 16 19:01:40 volumio volumio[1023]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 7 Feb 16 19:01:40 volumio volumio[1023]: info: CoreCommandRouter::volumioGetState Feb 16 19:01:41 volumio volumio[1023]: info: Feb 16 19:01:41 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:01:41 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:01:41 volumio volumio[1023]: info: Feb 16 19:01:41 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:01:41 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:01:41 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:01:41 volumio volumio[1023]: info: ------------------------------ 3ms Feb 16 19:01:41 volumio volumio[1023]: info: sendMpdCommand status took 2 milliseconds Feb 16 19:01:41 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:01:41 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:01:41 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:01:41 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:01:41 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:01:41 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:01:41 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:01:41 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":307231,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:01:41 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:01:41 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:01:41 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:01:41 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:01:41 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:01:41 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:01:41 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:01:41 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:01:41 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:01:41 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:01:41 volumio volumio[1023]: info: ------------------------------ 26ms Feb 16 19:01:42 volumio wpa_supplicant[922]: RRM: Ignoring radio measurement request: Not RRM network Feb 16 19:01:42 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 16 19:01:43 volumio volumio[1023]: info: Feb 16 19:01:43 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:01:43 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:01:43 volumio volumio[1023]: info: Feb 16 19:01:43 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:01:43 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:01:43 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:01:43 volumio volumio[1023]: info: ------------------------------ 2ms Feb 16 19:01:43 volumio volumio[1023]: info: sendMpdCommand status took 1 milliseconds Feb 16 19:01:43 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:01:43 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:01:43 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 0 milliseconds Feb 16 19:01:43 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:01:43 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:01:43 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:01:43 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:01:43 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":309547,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:01:43 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:01:43 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:01:43 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:01:43 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:01:43 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:01:43 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:01:43 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:01:43 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:01:43 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:01:43 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:01:43 volumio volumio[1023]: info: ------------------------------ 20ms Feb 16 19:01:44 volumio volumio[1023]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 8 Feb 16 19:01:44 volumio volumio[1023]: info: CoreCommandRouter::volumioGetState Feb 16 19:01:46 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 16 19:01:46 volumio volumio[1023]: info: Feb 16 19:01:46 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:01:46 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:01:46 volumio volumio[1023]: info: Feb 16 19:01:46 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:01:46 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:01:46 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:01:46 volumio volumio[1023]: info: ------------------------------ 4ms Feb 16 19:01:46 volumio volumio[1023]: info: sendMpdCommand status took 2 milliseconds Feb 16 19:01:46 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:01:46 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:01:46 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 0 milliseconds Feb 16 19:01:46 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:01:46 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:01:46 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:01:46 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:01:46 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":312333,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:01:46 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:01:46 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:01:46 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:01:46 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:01:46 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:01:46 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:01:46 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:01:46 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:01:46 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:01:46 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:01:46 volumio volumio[1023]: info: ------------------------------ 46ms Feb 16 19:01:46 volumio volumio[1023]: info: peppy_screensaver: Start PeppyMeter Feb 16 19:01:48 volumio volumio[1023]: info: Feb 16 19:01:48 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:01:48 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:01:48 volumio volumio[1023]: info: Feb 16 19:01:48 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:01:48 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:01:48 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:01:48 volumio volumio[1023]: info: ------------------------------ 2ms Feb 16 19:01:48 volumio volumio[1023]: info: sendMpdCommand status took 3 milliseconds Feb 16 19:01:48 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:01:48 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:01:48 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:01:48 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:01:48 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:01:48 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:01:48 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:01:48 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":314569,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:01:48 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:01:48 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:01:48 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:01:48 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:01:48 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:01:48 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:01:48 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:01:48 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:01:48 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:01:48 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:01:48 volumio volumio[1023]: info: ------------------------------ 44ms Feb 16 19:01:50 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 16 19:01:50 volumio volumio[1023]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 7 Feb 16 19:01:50 volumio volumio[1023]: info: CoreCommandRouter::volumioGetState Feb 16 19:01:51 volumio volumio[1023]: info: Feb 16 19:01:51 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:01:51 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:01:51 volumio volumio[1023]: info: Feb 16 19:01:51 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:01:51 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:01:51 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:01:51 volumio volumio[1023]: info: ------------------------------ 2ms Feb 16 19:01:51 volumio volumio[1023]: info: sendMpdCommand status took 3 milliseconds Feb 16 19:01:51 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:01:51 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:01:51 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:01:51 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:01:51 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:01:51 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:01:51 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:01:51 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":317263,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:01:51 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:01:51 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:01:51 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:01:51 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:01:51 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:01:51 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:01:51 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:01:51 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:01:51 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:01:51 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:01:51 volumio volumio[1023]: info: ------------------------------ 28ms Feb 16 19:01:52 volumio wpa_supplicant[922]: RRM: Ignoring radio measurement request: Not RRM network Feb 16 19:01:53 volumio volumio[1023]: info: Feb 16 19:01:53 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:01:53 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:01:53 volumio volumio[1023]: info: Feb 16 19:01:53 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:01:53 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:01:53 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:01:53 volumio volumio[1023]: info: ------------------------------ 2ms Feb 16 19:01:53 volumio volumio[1023]: info: sendMpdCommand status took 1 milliseconds Feb 16 19:01:53 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:01:53 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:01:53 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:01:53 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:01:53 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:01:53 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:01:53 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:01:53 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":319763,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:01:53 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:01:53 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:01:53 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:01:53 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:01:53 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:01:53 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:01:53 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:01:53 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:01:53 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:01:53 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:01:53 volumio volumio[1023]: info: ------------------------------ 23ms Feb 16 19:01:54 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 16 19:01:54 volumio volumio[1023]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 8 Feb 16 19:01:55 volumio volumio[1023]: info: peppy_screensaver: Start PeppyMeter Feb 16 19:01:56 volumio volumio[1023]: info: Feb 16 19:01:56 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Feb 16 19:01:56 volumio volumio[1023]: info: Ignoring MPD Status Update Feb 16 19:01:56 volumio volumio[1023]: info: Feb 16 19:01:56 volumio volumio[1023]: ---------------------------- MPD announces state update: player Feb 16 19:01:56 volumio volumio[1023]: info: ControllerMpd::getState Feb 16 19:01:56 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Feb 16 19:01:56 volumio volumio[1023]: info: ------------------------------ 4ms Feb 16 19:01:56 volumio volumio[1023]: info: sendMpdCommand status took 3 milliseconds Feb 16 19:01:56 volumio volumio[1023]: verbose: ControllerMpd::parseState Feb 16 19:01:56 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 16 19:01:56 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 16 19:01:56 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Feb 16 19:01:56 volumio volumio[1023]: info: ControllerMpd::pushState Feb 16 19:01:56 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Feb 16 19:01:56 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:01:56 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":322457,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""} Feb 16 19:01:56 volumio volumio[1023]: verbose: CURRENT POSITION 0 Feb 16 19:01:56 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Feb 16 19:01:56 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Feb 16 19:01:56 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Feb 16 19:01:56 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:01:56 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Feb 16 19:01:56 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 19:01:56 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:01:56 volumio volumio[1023]: info: CoreStateMachine::pushState Feb 16 19:01:56 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Feb 16 19:01:56 volumio volumio[1023]: info: ------------------------------ 29ms Feb 16 19:01:56 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Feb 16 19:01:56 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Feb 16 19:01:56 volumio volumio[1023]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 16 19:01:56 volumio volumio[1023]: Error: getaddrinfo -3007 Feb 16 19:01:56 volumio volumio[1023]: at errnoException (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:199:11) Feb 16 19:01:56 volumio volumio[1023]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:112:10) Feb 16 19:01:56 volumio volumio[1023]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) { Feb 16 19:01:56 volumio volumio[1023]: code: -3007, Feb 16 19:01:56 volumio volumio[1023]: errno: -3007, Feb 16 19:01:56 volumio volumio[1023]: syscall: 'getaddrinfo' Feb 16 19:01:56 volumio volumio[1023]: } Feb 16 19:01:56 volumio volumio[1023]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 16 19:01:57 volumio sudo[4854]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-16 19:00 Feb 16 19:01:57 volumio sudo[4854]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"