-- Logs begin at Sat 2024-11-23 13:05:36 CST, end at Sat 2024-11-23 13:44:49 CST. -- Nov 23 13:43:00 volumio kernel: usb 1-3.1: reset high-speed USB device number 6 using xhci_hcd Nov 23 13:43:00 volumio kernel: sd 2:0:0:0: Power-on or device reset occurred Nov 23 13:43:01 volumio kernel: sd 2:0:0:1: Power-on or device reset occurred Nov 23 13:43:08 volumio mount.exfat[900]: failed to read cluster 0x8d6ab Nov 23 13:43:08 volumio kernel: sd 2:0:0:1: [sdc] tag#0 access beyond end of device Nov 23 13:43:08 volumio kernel: I/O error, dev sdc, sector 148351232 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Nov 23 13:43:08 volumio kernel: Buffer I/O error on dev sdc1, logical block 18539808, async page read Nov 23 13:43:09 volumio mount.exfat[900]: failed to read cluster 0x8d6ab Nov 23 13:43:09 volumio kernel: sd 2:0:0:1: [sdc] tag#0 access beyond end of device Nov 23 13:43:10 volumio kernel: I/O error, dev sdc, sector 148351232 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Nov 23 13:43:10 volumio kernel: Buffer I/O error on dev sdc1, logical block 18539808, async page read Nov 23 13:43:16 volumio volumio[643]: info: Nov 23 13:43:16 volumio volumio[643]: ---------------------------- MPD announces state update: player Nov 23 13:43:16 volumio volumio[643]: info: ControllerMpd::getState Nov 23 13:43:16 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand status Nov 23 13:43:16 volumio volumio[643]: info: Nov 23 13:43:16 volumio volumio[643]: ---------------------------- MPD announces state update: player Nov 23 13:43:16 volumio volumio[643]: info: ControllerMpd::getState Nov 23 13:43:16 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand status Nov 23 13:43:16 volumio volumio[643]: info: Nov 23 13:43:16 volumio volumio[643]: ---------------------------- MPD announces state update: player Nov 23 13:43:16 volumio volumio[643]: info: ControllerMpd::getState Nov 23 13:43:16 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand status Nov 23 13:43:16 volumio volumio[643]: info: Nov 23 13:43:16 volumio volumio[643]: ---------------------------- MPD announces state update: player Nov 23 13:43:16 volumio volumio[643]: info: ControllerMpd::getState Nov 23 13:43:16 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand status Nov 23 13:43:16 volumio volumio[643]: info: sendMpdCommand status took 5 milliseconds Nov 23 13:43:16 volumio volumio[643]: info: sendMpdCommand status took 3 milliseconds Nov 23 13:43:16 volumio volumio[643]: verbose: ControllerMpd::parseState Nov 23 13:43:16 volumio volumio[643]: verbose: ControllerMpd::parseState Nov 23 13:43:16 volumio volumio[643]: verbose: ControllerMpd::parseState Nov 23 13:43:16 volumio volumio[643]: info: ControllerMpd::pushState Nov 23 13:43:16 volumio volumio[643]: info: CoreCommandRouter::servicePushState Nov 23 13:43:16 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:43:16 volumio volumio[643]: info: CorePlayQueue::getTrack 300 Nov 23 13:43:16 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 23 13:43:16 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:43:16 volumio volumio[643]: info: CorePlayQueue::getTrack 300 Nov 23 13:43:16 volumio volumio[643]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Nov 23 13:43:16 volumio volumio[643]: verbose: CURRENT POSITION 300 Nov 23 13:43:16 volumio volumio[643]: info: CoreStateMachine::syncState stateService stop Nov 23 13:43:16 volumio volumio[643]: info: CoreStateMachine::syncState currentStatus play Nov 23 13:43:16 volumio volumio[643]: info: CoreStateMachine::play index undefined Nov 23 13:43:16 volumio volumio[643]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 23 13:43:16 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:43:16 volumio volumio[643]: info: CorePlayQueue::getTrack 301 Nov 23 13:43:16 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 23 13:43:16 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:43:16 volumio volumio[643]: info: ControllerMpd::pushState Nov 23 13:43:16 volumio volumio[643]: info: CoreCommandRouter::servicePushState Nov 23 13:43:16 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:43:16 volumio volumio[643]: info: CorePlayQueue::getTrack 301 Nov 23 13:43:16 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:43:16 volumio volumio[643]: info: CorePlayQueue::getTrack 301 Nov 23 13:43:16 volumio volumio[643]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Nov 23 13:43:16 volumio volumio[643]: verbose: CURRENT POSITION 301 Nov 23 13:43:16 volumio volumio[643]: info: CoreStateMachine::syncState stateService stop Nov 23 13:43:16 volumio volumio[643]: info: CoreStateMachine::syncState currentStatus stop Nov 23 13:43:16 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:43:16 volumio volumio[643]: info: CorePlayQueue::getTrack 301 Nov 23 13:43:16 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:43:16 volumio volumio[643]: info: No code Nov 23 13:43:16 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:43:16 volumio volumio[643]: info: CorePlayQueue::getTrack 301 Nov 23 13:43:16 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:43:16 volumio volumio[643]: info: ControllerMpd::pushState Nov 23 13:43:16 volumio volumio[643]: info: CoreCommandRouter::servicePushState Nov 23 13:43:16 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:43:16 volumio volumio[643]: info: CorePlayQueue::getTrack 301 Nov 23 13:43:16 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:43:16 volumio volumio[643]: info: CorePlayQueue::getTrack 301 Nov 23 13:43:16 volumio volumio[643]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Nov 23 13:43:16 volumio volumio[643]: verbose: CURRENT POSITION 301 Nov 23 13:43:16 volumio volumio[643]: info: CoreStateMachine::syncState stateService stop Nov 23 13:43:16 volumio volumio[643]: info: CoreStateMachine::syncState currentStatus stop Nov 23 13:43:16 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:43:16 volumio volumio[643]: info: CorePlayQueue::getTrack 301 Nov 23 13:43:16 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:43:16 volumio volumio[643]: info: No code Nov 23 13:43:16 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:43:16 volumio volumio[643]: info: CorePlayQueue::getTrack 301 Nov 23 13:43:16 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:43:16 volumio volumio[643]: info: CorePlayQueue::getTrack 301 Nov 23 13:43:16 volumio volumio[643]: info: CoreStateMachine::startPlaybackTimer Nov 23 13:43:16 volumio volumio[643]: info: CorePlayQueue::getTrack 301 Nov 23 13:43:16 volumio volumio[643]: verbose: ControllerMpd::clearAddPlayTracks USB/sony/MUSIC/04.抖音流行歌曲980首/不必在乎我是谁 - 金润吉.mp3 Nov 23 13:43:16 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand stop Nov 23 13:43:16 volumio volumio[643]: info: ------------------------------ 72ms Nov 23 13:43:16 volumio volumio[643]: info: ------------------------------ 70ms Nov 23 13:43:16 volumio volumio[643]: info: ------------------------------ 69ms Nov 23 13:43:16 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:43:16 volumio volumio[643]: info: CorePlayQueue::getTrack 301 Nov 23 13:43:16 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 23 13:43:16 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:43:16 volumio volumio[643]: info: sendMpdCommand status took 78 milliseconds Nov 23 13:43:16 volumio volumio[643]: info: sendMpdCommand stop took 12 milliseconds Nov 23 13:43:16 volumio volumio[643]: verbose: ControllerMpd::parseState Nov 23 13:43:16 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand clear Nov 23 13:43:16 volumio volumio[643]: info: ControllerMpd::pushState Nov 23 13:43:16 volumio volumio[643]: info: CoreCommandRouter::servicePushState Nov 23 13:43:16 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:43:16 volumio volumio[643]: info: CorePlayQueue::getTrack 301 Nov 23 13:43:16 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:43:16 volumio volumio[643]: info: CorePlayQueue::getTrack 301 Nov 23 13:43:16 volumio volumio[643]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Nov 23 13:43:16 volumio volumio[643]: verbose: CURRENT POSITION 301 Nov 23 13:43:16 volumio volumio[643]: info: CoreStateMachine::syncState stateService stop Nov 23 13:43:16 volumio volumio[643]: info: CoreStateMachine::syncState currentStatus stop Nov 23 13:43:16 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:43:16 volumio volumio[643]: info: CorePlayQueue::getTrack 301 Nov 23 13:43:16 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:43:16 volumio volumio[643]: info: No code Nov 23 13:43:16 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:43:16 volumio volumio[643]: info: CorePlayQueue::getTrack 301 Nov 23 13:43:16 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:43:16 volumio volumio[643]: info: ------------------------------ 103ms Nov 23 13:43:16 volumio volumio[643]: info: Nov 23 13:43:16 volumio volumio[643]: ---------------------------- MPD announces system playlist update Nov 23 13:43:16 volumio volumio[643]: info: Ignoring MPD Status Update Nov 23 13:43:16 volumio volumio[643]: info: sendMpdCommand clear took 63 milliseconds Nov 23 13:43:16 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand add "USB/sony/MUSIC/04.抖音流行歌曲980首/不必在乎我是谁 - 金润吉.mp3" Nov 23 13:43:16 volumio volumio[643]: info: Nov 23 13:43:16 volumio volumio[643]: ---------------------------- MPD announces system playlist update Nov 23 13:43:16 volumio volumio[643]: info: Ignoring MPD Status Update Nov 23 13:43:16 volumio volumio[643]: info: Nov 23 13:43:16 volumio volumio[643]: ---------------------------- MPD announces system playlist update Nov 23 13:43:16 volumio volumio[643]: info: Ignoring MPD Status Update Nov 23 13:43:16 volumio volumio[643]: info: Nov 23 13:43:16 volumio volumio[643]: ---------------------------- MPD announces system playlist update Nov 23 13:43:16 volumio volumio[643]: info: Ignoring MPD Status Update Nov 23 13:43:16 volumio volumio[643]: error: updateQueue error: null Nov 23 13:43:16 volumio volumio[643]: info: Nov 23 13:43:16 volumio volumio[643]: ---------------------------- MPD announces system playlist update Nov 23 13:43:16 volumio volumio[643]: info: Ignoring MPD Status Update Nov 23 13:43:16 volumio volumio[643]: info: ------------------------------ 7ms Nov 23 13:43:16 volumio volumio[643]: info: sendMpdCommand add "USB/sony/MUSIC/04.抖音流行歌曲980首/不必在乎我是谁 - 金润吉.mp3" took 6 milliseconds Nov 23 13:43:16 volumio volumio[643]: info: ------------------------------ 7ms Nov 23 13:43:16 volumio volumio[643]: info: ------------------------------ 6ms Nov 23 13:43:16 volumio volumio[643]: info: ------------------------------ 6ms Nov 23 13:43:16 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand play Nov 23 13:43:16 volumio volumio[643]: info: Nov 23 13:43:16 volumio volumio[643]: ---------------------------- MPD announces system playlist update Nov 23 13:43:16 volumio volumio[643]: info: Ignoring MPD Status Update Nov 23 13:43:16 volumio volumio[643]: info: Nov 23 13:43:16 volumio volumio[643]: ---------------------------- MPD announces system playlist update Nov 23 13:43:16 volumio volumio[643]: info: Ignoring MPD Status Update Nov 23 13:43:16 volumio volumio[643]: info: Nov 23 13:43:16 volumio volumio[643]: ---------------------------- MPD announces system playlist update Nov 23 13:43:16 volumio volumio[643]: info: Ignoring MPD Status Update Nov 23 13:43:16 volumio volumio[643]: info: ------------------------------ 7ms Nov 23 13:43:16 volumio volumio[643]: info: sendMpdCommand play took 4 milliseconds Nov 23 13:43:16 volumio volumio[643]: info: ------------------------------ 3ms Nov 23 13:43:16 volumio volumio[643]: info: ------------------------------ 2ms Nov 23 13:43:16 volumio mount.exfat[900]: failed to read cluster 0x8d6cf Nov 23 13:43:16 volumio mount.exfat[900]: failed to read cluster 0x8d6cf Nov 23 13:43:16 volumio mount.exfat[900]: failed to read cluster 0x8d6d0 Nov 23 13:43:16 volumio kernel: sd 2:0:0:1: [sdc] tag#0 access beyond end of device Nov 23 13:43:16 volumio kernel: I/O error, dev sdc, sector 148360448 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 2 Nov 23 13:43:16 volumio kernel: sd 2:0:0:1: [sdc] tag#0 access beyond end of device Nov 23 13:43:16 volumio kernel: I/O error, dev sdc, sector 148360448 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Nov 23 13:43:16 volumio kernel: Buffer I/O error on dev sdc1, logical block 18540960, async page read Nov 23 13:43:16 volumio kernel: sd 2:0:0:1: [sdc] tag#0 access beyond end of device Nov 23 13:43:16 volumio kernel: I/O error, dev sdc, sector 148360464 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 2 Nov 23 13:43:16 volumio kernel: sd 2:0:0:1: [sdc] tag#0 access beyond end of device Nov 23 13:43:16 volumio kernel: I/O error, dev sdc, sector 148360464 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Nov 23 13:43:16 volumio kernel: Buffer I/O error on dev sdc1, logical block 18540962, async page read Nov 23 13:43:16 volumio kernel: sd 2:0:0:1: [sdc] tag#0 access beyond end of device Nov 23 13:43:16 volumio kernel: I/O error, dev sdc, sector 148360720 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 2 Nov 23 13:43:16 volumio kernel: sd 2:0:0:1: [sdc] tag#0 access beyond end of device Nov 23 13:43:16 volumio kernel: I/O error, dev sdc, sector 148360720 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Nov 23 13:43:16 volumio kernel: Buffer I/O error on dev sdc1, logical block 18540994, async page read Nov 23 13:43:16 volumio volumio[643]: info: Nov 23 13:43:16 volumio volumio[643]: ---------------------------- MPD announces state update: player Nov 23 13:43:16 volumio volumio[643]: info: ControllerMpd::getState Nov 23 13:43:16 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand status Nov 23 13:43:16 volumio volumio[643]: info: Nov 23 13:43:16 volumio volumio[643]: ---------------------------- MPD announces state update: player Nov 23 13:43:16 volumio volumio[643]: info: ControllerMpd::getState Nov 23 13:43:16 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand status Nov 23 13:43:16 volumio volumio[643]: info: Nov 23 13:43:16 volumio volumio[643]: ---------------------------- MPD announces state update: player Nov 23 13:43:16 volumio volumio[643]: info: ControllerMpd::getState Nov 23 13:43:16 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand status Nov 23 13:43:16 volumio volumio[643]: info: Nov 23 13:43:16 volumio volumio[643]: ---------------------------- MPD announces state update: player Nov 23 13:43:16 volumio volumio[643]: info: ControllerMpd::getState Nov 23 13:43:16 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand status Nov 23 13:43:16 volumio volumio[643]: info: Nov 23 13:43:16 volumio volumio[643]: ---------------------------- MPD announces state update: player Nov 23 13:43:16 volumio volumio[643]: info: ControllerMpd::getState Nov 23 13:43:16 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand status Nov 23 13:43:16 volumio volumio[643]: info: sendMpdCommand status took 5 milliseconds Nov 23 13:43:16 volumio volumio[643]: info: sendMpdCommand status took 4 milliseconds Nov 23 13:43:16 volumio volumio[643]: info: sendMpdCommand status took 3 milliseconds Nov 23 13:43:16 volumio volumio[643]: info: sendMpdCommand status took 2 milliseconds Nov 23 13:43:16 volumio volumio[643]: verbose: ControllerMpd::parseState Nov 23 13:43:16 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 23 13:43:16 volumio volumio[643]: verbose: ControllerMpd::parseState Nov 23 13:43:16 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 23 13:43:16 volumio volumio[643]: verbose: ControllerMpd::parseState Nov 23 13:43:16 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 23 13:43:16 volumio volumio[643]: verbose: ControllerMpd::parseState Nov 23 13:43:16 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 23 13:43:16 volumio volumio[643]: info: Nov 23 13:43:16 volumio volumio[643]: ---------------------------- MPD announces state update: player Nov 23 13:43:16 volumio volumio[643]: info: ControllerMpd::getState Nov 23 13:43:16 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand status Nov 23 13:43:16 volumio volumio[643]: info: Nov 23 13:43:16 volumio volumio[643]: ---------------------------- MPD announces state update: player Nov 23 13:43:16 volumio volumio[643]: info: ControllerMpd::getState Nov 23 13:43:16 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand status Nov 23 13:43:16 volumio volumio[643]: info: Nov 23 13:43:16 volumio volumio[643]: ---------------------------- MPD announces state update: player Nov 23 13:43:16 volumio volumio[643]: info: ControllerMpd::getState Nov 23 13:43:16 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand status Nov 23 13:43:16 volumio volumio[643]: info: sendMpdCommand status took 12 milliseconds Nov 23 13:43:16 volumio volumio[643]: info: sendMpdCommand playlistinfo took 11 milliseconds Nov 23 13:43:16 volumio volumio[643]: info: sendMpdCommand playlistinfo took 11 milliseconds Nov 23 13:43:16 volumio volumio[643]: info: sendMpdCommand playlistinfo took 10 milliseconds Nov 23 13:43:16 volumio volumio[643]: info: sendMpdCommand status took 8 milliseconds Nov 23 13:43:16 volumio volumio[643]: info: sendMpdCommand status took 7 milliseconds Nov 23 13:43:16 volumio volumio[643]: info: sendMpdCommand status took 6 milliseconds Nov 23 13:43:16 volumio volumio[643]: verbose: ControllerMpd::parseState Nov 23 13:43:16 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 23 13:43:16 volumio volumio[643]: verbose: ControllerMpd::parseTrackInfo Nov 23 13:43:16 volumio volumio[643]: verbose: ControllerMpd::parseTrackInfo Nov 23 13:43:16 volumio volumio[643]: verbose: ControllerMpd::parseTrackInfo Nov 23 13:43:16 volumio volumio[643]: verbose: ControllerMpd::parseTrackInfo Nov 23 13:43:16 volumio volumio[643]: verbose: ControllerMpd::parseState Nov 23 13:43:16 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 23 13:43:16 volumio volumio[643]: verbose: ControllerMpd::parseState Nov 23 13:43:16 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 23 13:43:16 volumio volumio[643]: verbose: ControllerMpd::parseState Nov 23 13:43:16 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 23 13:43:16 volumio volumio[643]: info: ControllerMpd::pushState Nov 23 13:43:16 volumio volumio[643]: info: CoreCommandRouter::servicePushState Nov 23 13:43:16 volumio volumio[643]: info: CorePlayQueue::getTrack 301 Nov 23 13:43:16 volumio volumio[643]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":235,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"不必在乎我是谁","artist":"金润吉","album":"不必在乎我是谁","uri":"USB/sony/MUSIC/04.抖音流行歌曲980首/不必在乎我是谁 - 金润吉.mp3","trackType":"mp3"} Nov 23 13:43:16 volumio volumio[643]: verbose: CURRENT POSITION 301 Nov 23 13:43:16 volumio volumio[643]: info: CoreStateMachine::syncState stateService play Nov 23 13:43:16 volumio volumio[643]: info: CoreStateMachine::syncState currentStatus stop Nov 23 13:43:16 volumio volumio[643]: info: ControllerMpd::pushState Nov 23 13:43:16 volumio volumio[643]: info: CoreCommandRouter::servicePushState Nov 23 13:43:16 volumio volumio[643]: info: CorePlayQueue::getTrack 301 Nov 23 13:43:16 volumio volumio[643]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":235,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"不必在乎我是谁","artist":"金润吉","album":"不必在乎我是谁","uri":"USB/sony/MUSIC/04.抖音流行歌曲980首/不必在乎我是谁 - 金润吉.mp3","trackType":"mp3"} Nov 23 13:43:16 volumio volumio[643]: verbose: CURRENT POSITION 301 Nov 23 13:43:16 volumio volumio[643]: info: CoreStateMachine::syncState stateService play Nov 23 13:43:16 volumio volumio[643]: info: CoreStateMachine::syncState currentStatus play Nov 23 13:43:16 volumio volumio[643]: info: Received an update from plugin. extracting info from payload Nov 23 13:43:16 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:43:16 volumio volumio[643]: info: CorePlayQueue::getTrack 301 Nov 23 13:43:16 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 23 13:43:16 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:43:16 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:43:16 volumio volumio[643]: info: CorePlayQueue::getTrack 301 Nov 23 13:43:16 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:43:16 volumio volumio[643]: info: ControllerMpd::pushState Nov 23 13:43:16 volumio volumio[643]: info: CoreCommandRouter::servicePushState Nov 23 13:43:16 volumio volumio[643]: info: CorePlayQueue::getTrack 301 Nov 23 13:43:16 volumio volumio[643]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":235,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"不必在乎我是谁","artist":"金润吉","album":"不必在乎我是谁","uri":"USB/sony/MUSIC/04.抖音流行歌曲980首/不必在乎我是谁 - 金润吉.mp3","trackType":"mp3"} Nov 23 13:43:16 volumio volumio[643]: verbose: CURRENT POSITION 301 Nov 23 13:43:16 volumio volumio[643]: info: CoreStateMachine::syncState stateService play Nov 23 13:43:16 volumio volumio[643]: info: CoreStateMachine::syncState currentStatus play Nov 23 13:43:16 volumio volumio[643]: info: Received an update from plugin. extracting info from payload Nov 23 13:43:16 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:43:16 volumio volumio[643]: info: CorePlayQueue::getTrack 301 Nov 23 13:43:16 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:43:16 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:43:16 volumio volumio[643]: info: CorePlayQueue::getTrack 301 Nov 23 13:43:16 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:43:16 volumio volumio[643]: info: ControllerMpd::pushState Nov 23 13:43:16 volumio volumio[643]: info: CoreCommandRouter::servicePushState Nov 23 13:43:16 volumio volumio[643]: info: CorePlayQueue::getTrack 301 Nov 23 13:43:16 volumio volumio[643]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":235,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"不必在乎我是谁","artist":"金润吉","album":"不必在乎我是谁","uri":"USB/sony/MUSIC/04.抖音流行歌曲980首/不必在乎我是谁 - 金润吉.mp3","trackType":"mp3"} Nov 23 13:43:16 volumio volumio[643]: verbose: CURRENT POSITION 301 Nov 23 13:43:16 volumio volumio[643]: info: CoreStateMachine::syncState stateService play Nov 23 13:43:16 volumio volumio[643]: info: CoreStateMachine::syncState currentStatus play Nov 23 13:43:16 volumio volumio[643]: info: Received an update from plugin. extracting info from payload Nov 23 13:43:16 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:43:16 volumio volumio[643]: info: CorePlayQueue::getTrack 301 Nov 23 13:43:16 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:43:16 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:43:16 volumio volumio[643]: info: CorePlayQueue::getTrack 301 Nov 23 13:43:16 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:43:16 volumio volumio[643]: info: ------------------------------ 38ms Nov 23 13:43:16 volumio volumio[643]: info: ------------------------------ 69ms Nov 23 13:43:16 volumio volumio[643]: info: ------------------------------ 69ms Nov 23 13:43:16 volumio volumio[643]: info: ------------------------------ 69ms Nov 23 13:43:16 volumio volumio[643]: info: sendMpdCommand playlistinfo took 54 milliseconds Nov 23 13:43:16 volumio volumio[643]: info: sendMpdCommand playlistinfo took 53 milliseconds Nov 23 13:43:16 volumio volumio[643]: info: sendMpdCommand playlistinfo took 54 milliseconds Nov 23 13:43:16 volumio volumio[643]: info: sendMpdCommand playlistinfo took 53 milliseconds Nov 23 13:43:16 volumio volumio[643]: verbose: ControllerMpd::parseTrackInfo Nov 23 13:43:16 volumio volumio[643]: verbose: ControllerMpd::parseTrackInfo Nov 23 13:43:16 volumio volumio[643]: verbose: ControllerMpd::parseTrackInfo Nov 23 13:43:16 volumio volumio[643]: verbose: ControllerMpd::parseTrackInfo Nov 23 13:43:16 volumio volumio[643]: info: ControllerMpd::pushState Nov 23 13:43:16 volumio volumio[643]: info: CoreCommandRouter::servicePushState Nov 23 13:43:16 volumio volumio[643]: info: CorePlayQueue::getTrack 301 Nov 23 13:43:16 volumio volumio[643]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":235,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"不必在乎我是谁","artist":"金润吉","album":"不必在乎我是谁","uri":"USB/sony/MUSIC/04.抖音流行歌曲980首/不必在乎我是谁 - 金润吉.mp3","trackType":"mp3"} Nov 23 13:43:16 volumio volumio[643]: verbose: CURRENT POSITION 301 Nov 23 13:43:16 volumio volumio[643]: info: CoreStateMachine::syncState stateService play Nov 23 13:43:16 volumio volumio[643]: info: CoreStateMachine::syncState currentStatus play Nov 23 13:43:16 volumio volumio[643]: info: Received an update from plugin. extracting info from payload Nov 23 13:43:16 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:43:16 volumio volumio[643]: info: CorePlayQueue::getTrack 301 Nov 23 13:43:16 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:43:16 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:43:16 volumio volumio[643]: info: CorePlayQueue::getTrack 301 Nov 23 13:43:16 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:43:16 volumio volumio[643]: info: ControllerMpd::pushState Nov 23 13:43:16 volumio volumio[643]: info: CoreCommandRouter::servicePushState Nov 23 13:43:16 volumio volumio[643]: info: CorePlayQueue::getTrack 301 Nov 23 13:43:16 volumio volumio[643]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":235,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"不必在乎我是谁","artist":"金润吉","album":"不必在乎我是谁","uri":"USB/sony/MUSIC/04.抖音流行歌曲980首/不必在乎我是谁 - 金润吉.mp3","trackType":"mp3"} Nov 23 13:43:16 volumio volumio[643]: verbose: CURRENT POSITION 301 Nov 23 13:43:16 volumio volumio[643]: info: CoreStateMachine::syncState stateService play Nov 23 13:43:16 volumio volumio[643]: info: CoreStateMachine::syncState currentStatus play Nov 23 13:43:16 volumio volumio[643]: info: Received an update from plugin. extracting info from payload Nov 23 13:43:16 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:43:16 volumio volumio[643]: info: CorePlayQueue::getTrack 301 Nov 23 13:43:16 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:43:16 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:43:16 volumio volumio[643]: info: CorePlayQueue::getTrack 301 Nov 23 13:43:16 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:43:16 volumio volumio[643]: info: ControllerMpd::pushState Nov 23 13:43:16 volumio volumio[643]: info: CoreCommandRouter::servicePushState Nov 23 13:43:16 volumio volumio[643]: info: CorePlayQueue::getTrack 301 Nov 23 13:43:16 volumio volumio[643]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":235,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"不必在乎我是谁","artist":"金润吉","album":"不必在乎我是谁","uri":"USB/sony/MUSIC/04.抖音流行歌曲980首/不必在乎我是谁 - 金润吉.mp3","trackType":"mp3"} Nov 23 13:43:16 volumio volumio[643]: verbose: CURRENT POSITION 301 Nov 23 13:43:16 volumio volumio[643]: info: CoreStateMachine::syncState stateService play Nov 23 13:43:16 volumio volumio[643]: info: CoreStateMachine::syncState currentStatus play Nov 23 13:43:16 volumio volumio[643]: info: Received an update from plugin. extracting info from payload Nov 23 13:43:16 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:43:16 volumio volumio[643]: info: CorePlayQueue::getTrack 301 Nov 23 13:43:16 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:43:16 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:43:16 volumio volumio[643]: info: CorePlayQueue::getTrack 301 Nov 23 13:43:16 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:43:16 volumio volumio[643]: info: ControllerMpd::pushState Nov 23 13:43:16 volumio volumio[643]: info: CoreCommandRouter::servicePushState Nov 23 13:43:16 volumio volumio[643]: info: CorePlayQueue::getTrack 301 Nov 23 13:43:16 volumio volumio[643]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":235,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"不必在乎我是谁","artist":"金润吉","album":"不必在乎我是谁","uri":"USB/sony/MUSIC/04.抖音流行歌曲980首/不必在乎我是谁 - 金润吉.mp3","trackType":"mp3"} Nov 23 13:43:16 volumio volumio[643]: verbose: CURRENT POSITION 301 Nov 23 13:43:16 volumio volumio[643]: info: CoreStateMachine::syncState stateService play Nov 23 13:43:16 volumio volumio[643]: info: CoreStateMachine::syncState currentStatus play Nov 23 13:43:16 volumio volumio[643]: info: Received an update from plugin. extracting info from payload Nov 23 13:43:16 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:43:16 volumio volumio[643]: info: CorePlayQueue::getTrack 301 Nov 23 13:43:16 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:43:16 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:43:16 volumio volumio[643]: info: CorePlayQueue::getTrack 301 Nov 23 13:43:16 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:43:16 volumio volumio[643]: info: ------------------------------ 179ms Nov 23 13:43:16 volumio volumio[643]: info: ------------------------------ 176ms Nov 23 13:43:16 volumio volumio[643]: info: ------------------------------ 176ms Nov 23 13:43:16 volumio volumio[643]: info: ------------------------------ 175ms Nov 23 13:43:23 volumio mount.exfat[900]: failed to read cluster 0x8d6cf Nov 23 13:43:23 volumio kernel: sd 2:0:0:1: [sdc] tag#0 access beyond end of device Nov 23 13:43:23 volumio kernel: I/O error, dev sdc, sector 148360448 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Nov 23 13:43:23 volumio kernel: Buffer I/O error on dev sdc1, logical block 18540960, async page read Nov 23 13:43:24 volumio mount.exfat[900]: failed to read cluster 0x8d6cf Nov 23 13:43:24 volumio kernel: sd 2:0:0:1: [sdc] tag#0 access beyond end of device Nov 23 13:43:24 volumio kernel: I/O error, dev sdc, sector 148360448 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Nov 23 13:43:24 volumio kernel: Buffer I/O error on dev sdc1, logical block 18540960, async page read Nov 23 13:43:30 volumio volumio[643]: info: Nov 23 13:43:30 volumio volumio[643]: ---------------------------- MPD announces state update: player Nov 23 13:43:30 volumio volumio[643]: info: ControllerMpd::getState Nov 23 13:43:30 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand status Nov 23 13:43:30 volumio volumio[643]: info: Nov 23 13:43:30 volumio volumio[643]: ---------------------------- MPD announces state update: player Nov 23 13:43:30 volumio volumio[643]: info: ControllerMpd::getState Nov 23 13:43:30 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand status Nov 23 13:43:30 volumio volumio[643]: info: Nov 23 13:43:30 volumio volumio[643]: ---------------------------- MPD announces state update: player Nov 23 13:43:30 volumio volumio[643]: info: ControllerMpd::getState Nov 23 13:43:30 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand status Nov 23 13:43:30 volumio volumio[643]: info: Nov 23 13:43:30 volumio volumio[643]: ---------------------------- MPD announces state update: player Nov 23 13:43:30 volumio volumio[643]: info: ControllerMpd::getState Nov 23 13:43:30 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand status Nov 23 13:43:30 volumio volumio[643]: info: sendMpdCommand status took 4 milliseconds Nov 23 13:43:30 volumio volumio[643]: info: sendMpdCommand status took 3 milliseconds Nov 23 13:43:30 volumio volumio[643]: info: sendMpdCommand status took 3 milliseconds Nov 23 13:43:30 volumio volumio[643]: verbose: ControllerMpd::parseState Nov 23 13:43:30 volumio volumio[643]: verbose: ControllerMpd::parseState Nov 23 13:43:30 volumio volumio[643]: verbose: ControllerMpd::parseState Nov 23 13:43:30 volumio volumio[643]: info: ControllerMpd::pushState Nov 23 13:43:30 volumio volumio[643]: info: CoreCommandRouter::servicePushState Nov 23 13:43:30 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:43:30 volumio volumio[643]: info: CorePlayQueue::getTrack 301 Nov 23 13:43:30 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 23 13:43:30 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:43:30 volumio volumio[643]: info: CorePlayQueue::getTrack 301 Nov 23 13:43:30 volumio volumio[643]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Nov 23 13:43:30 volumio volumio[643]: verbose: CURRENT POSITION 301 Nov 23 13:43:30 volumio volumio[643]: info: CoreStateMachine::syncState stateService stop Nov 23 13:43:30 volumio volumio[643]: info: CoreStateMachine::syncState currentStatus play Nov 23 13:43:30 volumio volumio[643]: info: CoreStateMachine::play index undefined Nov 23 13:43:30 volumio volumio[643]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 23 13:43:30 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:43:30 volumio volumio[643]: info: CorePlayQueue::getTrack 302 Nov 23 13:43:30 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 23 13:43:30 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:43:30 volumio volumio[643]: info: ControllerMpd::pushState Nov 23 13:43:30 volumio volumio[643]: info: CoreCommandRouter::servicePushState Nov 23 13:43:30 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:43:30 volumio volumio[643]: info: CorePlayQueue::getTrack 302 Nov 23 13:43:30 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:43:30 volumio volumio[643]: info: CorePlayQueue::getTrack 302 Nov 23 13:43:30 volumio volumio[643]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Nov 23 13:43:30 volumio volumio[643]: verbose: CURRENT POSITION 302 Nov 23 13:43:30 volumio volumio[643]: info: CoreStateMachine::syncState stateService stop Nov 23 13:43:30 volumio volumio[643]: info: CoreStateMachine::syncState currentStatus stop Nov 23 13:43:30 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:43:30 volumio volumio[643]: info: CorePlayQueue::getTrack 302 Nov 23 13:43:30 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:43:30 volumio volumio[643]: info: No code Nov 23 13:43:30 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:43:30 volumio volumio[643]: info: CorePlayQueue::getTrack 302 Nov 23 13:43:30 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:43:30 volumio volumio[643]: info: ControllerMpd::pushState Nov 23 13:43:30 volumio volumio[643]: info: CoreCommandRouter::servicePushState Nov 23 13:43:30 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:43:30 volumio volumio[643]: info: CorePlayQueue::getTrack 302 Nov 23 13:43:30 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:43:30 volumio volumio[643]: info: CorePlayQueue::getTrack 302 Nov 23 13:43:30 volumio volumio[643]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Nov 23 13:43:30 volumio volumio[643]: verbose: CURRENT POSITION 302 Nov 23 13:43:30 volumio volumio[643]: info: CoreStateMachine::syncState stateService stop Nov 23 13:43:30 volumio volumio[643]: info: CoreStateMachine::syncState currentStatus stop Nov 23 13:43:30 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:43:30 volumio volumio[643]: info: CorePlayQueue::getTrack 302 Nov 23 13:43:30 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:43:30 volumio volumio[643]: info: No code Nov 23 13:43:30 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:43:30 volumio volumio[643]: info: CorePlayQueue::getTrack 302 Nov 23 13:43:30 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:43:30 volumio volumio[643]: info: CorePlayQueue::getTrack 302 Nov 23 13:43:30 volumio volumio[643]: info: CoreStateMachine::startPlaybackTimer Nov 23 13:43:30 volumio volumio[643]: info: CorePlayQueue::getTrack 302 Nov 23 13:43:30 volumio volumio[643]: verbose: ControllerMpd::clearAddPlayTracks USB/sony/MUSIC/04.抖音流行歌曲980首/不挽留没回头 - 王小乱.mp3 Nov 23 13:43:30 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand stop Nov 23 13:43:30 volumio volumio[643]: info: ------------------------------ 79ms Nov 23 13:43:30 volumio volumio[643]: info: ------------------------------ 77ms Nov 23 13:43:30 volumio volumio[643]: info: ------------------------------ 77ms Nov 23 13:43:30 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:43:30 volumio volumio[643]: info: CorePlayQueue::getTrack 302 Nov 23 13:43:30 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 23 13:43:30 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:43:30 volumio volumio[643]: info: sendMpdCommand status took 89 milliseconds Nov 23 13:43:30 volumio volumio[643]: info: sendMpdCommand stop took 15 milliseconds Nov 23 13:43:30 volumio volumio[643]: verbose: ControllerMpd::parseState Nov 23 13:43:30 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand clear Nov 23 13:43:30 volumio volumio[643]: info: ControllerMpd::pushState Nov 23 13:43:30 volumio volumio[643]: info: CoreCommandRouter::servicePushState Nov 23 13:43:30 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:43:30 volumio volumio[643]: info: CorePlayQueue::getTrack 302 Nov 23 13:43:30 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 23 13:43:30 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:43:30 volumio volumio[643]: info: CorePlayQueue::getTrack 302 Nov 23 13:43:30 volumio volumio[643]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Nov 23 13:43:30 volumio volumio[643]: verbose: CURRENT POSITION 302 Nov 23 13:43:30 volumio volumio[643]: info: CoreStateMachine::syncState stateService stop Nov 23 13:43:30 volumio volumio[643]: info: CoreStateMachine::syncState currentStatus stop Nov 23 13:43:30 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:43:30 volumio volumio[643]: info: CorePlayQueue::getTrack 302 Nov 23 13:43:30 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:43:30 volumio volumio[643]: info: No code Nov 23 13:43:30 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:43:30 volumio volumio[643]: info: CorePlayQueue::getTrack 302 Nov 23 13:43:30 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:43:30 volumio volumio[643]: info: ------------------------------ 118ms Nov 23 13:43:30 volumio volumio[643]: info: Nov 23 13:43:30 volumio volumio[643]: ---------------------------- MPD announces system playlist update Nov 23 13:43:30 volumio volumio[643]: info: Ignoring MPD Status Update Nov 23 13:43:30 volumio volumio[643]: info: sendMpdCommand clear took 82 milliseconds Nov 23 13:43:30 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand add "USB/sony/MUSIC/04.抖音流行歌曲980首/不挽留没回头 - 王小乱.mp3" Nov 23 13:43:30 volumio volumio[643]: info: Nov 23 13:43:30 volumio volumio[643]: ---------------------------- MPD announces system playlist update Nov 23 13:43:30 volumio volumio[643]: info: Ignoring MPD Status Update Nov 23 13:43:30 volumio volumio[643]: info: Nov 23 13:43:30 volumio volumio[643]: ---------------------------- MPD announces system playlist update Nov 23 13:43:30 volumio volumio[643]: info: Ignoring MPD Status Update Nov 23 13:43:30 volumio volumio[643]: info: Nov 23 13:43:30 volumio volumio[643]: ---------------------------- MPD announces system playlist update Nov 23 13:43:30 volumio volumio[643]: info: Ignoring MPD Status Update Nov 23 13:43:30 volumio volumio[643]: error: updateQueue error: null Nov 23 13:43:30 volumio volumio[643]: info: Nov 23 13:43:30 volumio volumio[643]: ---------------------------- MPD announces system playlist update Nov 23 13:43:30 volumio volumio[643]: info: Ignoring MPD Status Update Nov 23 13:43:30 volumio volumio[643]: info: ------------------------------ 8ms Nov 23 13:43:30 volumio volumio[643]: info: sendMpdCommand add "USB/sony/MUSIC/04.抖音流行歌曲980首/不挽留没回头 - 王小乱.mp3" took 7 milliseconds Nov 23 13:43:30 volumio volumio[643]: info: ------------------------------ 6ms Nov 23 13:43:30 volumio volumio[643]: info: ------------------------------ 5ms Nov 23 13:43:30 volumio volumio[643]: info: ------------------------------ 4ms Nov 23 13:43:30 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand play Nov 23 13:43:30 volumio volumio[643]: info: Nov 23 13:43:30 volumio volumio[643]: ---------------------------- MPD announces system playlist update Nov 23 13:43:30 volumio volumio[643]: info: Ignoring MPD Status Update Nov 23 13:43:30 volumio volumio[643]: info: Nov 23 13:43:30 volumio volumio[643]: ---------------------------- MPD announces system playlist update Nov 23 13:43:30 volumio volumio[643]: info: Ignoring MPD Status Update Nov 23 13:43:30 volumio volumio[643]: info: Nov 23 13:43:30 volumio volumio[643]: ---------------------------- MPD announces system playlist update Nov 23 13:43:30 volumio volumio[643]: info: Ignoring MPD Status Update Nov 23 13:43:30 volumio volumio[643]: info: Nov 23 13:43:30 volumio volumio[643]: ---------------------------- MPD announces state update: player Nov 23 13:43:30 volumio volumio[643]: info: ------------------------------ 41ms Nov 23 13:43:30 volumio volumio[643]: info: sendMpdCommand play took 40 milliseconds Nov 23 13:43:30 volumio volumio[643]: info: ------------------------------ 39ms Nov 23 13:43:30 volumio volumio[643]: info: ------------------------------ 39ms Nov 23 13:43:30 volumio volumio[643]: info: ------------------------------ 38ms Nov 23 13:43:30 volumio volumio[643]: info: ControllerMpd::getState Nov 23 13:43:30 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand status Nov 23 13:43:30 volumio volumio[643]: info: Nov 23 13:43:30 volumio volumio[643]: ---------------------------- MPD announces state update: player Nov 23 13:43:30 volumio volumio[643]: info: ControllerMpd::getState Nov 23 13:43:30 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand status Nov 23 13:43:30 volumio volumio[643]: info: Nov 23 13:43:30 volumio volumio[643]: ---------------------------- MPD announces state update: player Nov 23 13:43:30 volumio volumio[643]: info: ControllerMpd::getState Nov 23 13:43:30 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand status Nov 23 13:43:30 volumio volumio[643]: info: Nov 23 13:43:30 volumio volumio[643]: ---------------------------- MPD announces state update: player Nov 23 13:43:30 volumio volumio[643]: info: ControllerMpd::getState Nov 23 13:43:30 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand status Nov 23 13:43:30 volumio volumio[643]: info: Nov 23 13:43:30 volumio volumio[643]: ---------------------------- MPD announces state update: player Nov 23 13:43:30 volumio volumio[643]: info: ControllerMpd::getState Nov 23 13:43:30 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand status Nov 23 13:43:30 volumio volumio[643]: info: sendMpdCommand status took 4 milliseconds Nov 23 13:43:30 volumio volumio[643]: info: sendMpdCommand status took 3 milliseconds Nov 23 13:43:30 volumio volumio[643]: info: sendMpdCommand status took 3 milliseconds Nov 23 13:43:30 volumio volumio[643]: info: sendMpdCommand status took 2 milliseconds Nov 23 13:43:30 volumio volumio[643]: verbose: ControllerMpd::parseState Nov 23 13:43:30 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 23 13:43:30 volumio volumio[643]: verbose: ControllerMpd::parseState Nov 23 13:43:30 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 23 13:43:30 volumio volumio[643]: verbose: ControllerMpd::parseState Nov 23 13:43:30 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 23 13:43:30 volumio volumio[643]: verbose: ControllerMpd::parseState Nov 23 13:43:30 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 23 13:43:30 volumio volumio[643]: info: Nov 23 13:43:30 volumio volumio[643]: ---------------------------- MPD announces state update: player Nov 23 13:43:30 volumio volumio[643]: info: ControllerMpd::getState Nov 23 13:43:30 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand status Nov 23 13:43:30 volumio volumio[643]: info: Nov 23 13:43:30 volumio volumio[643]: ---------------------------- MPD announces state update: player Nov 23 13:43:30 volumio volumio[643]: info: ControllerMpd::getState Nov 23 13:43:30 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand status Nov 23 13:43:30 volumio volumio[643]: info: Nov 23 13:43:30 volumio volumio[643]: ---------------------------- MPD announces state update: player Nov 23 13:43:30 volumio volumio[643]: info: ControllerMpd::getState Nov 23 13:43:30 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand status Nov 23 13:43:30 volumio volumio[643]: info: sendMpdCommand status took 6 milliseconds Nov 23 13:43:30 volumio volumio[643]: info: sendMpdCommand playlistinfo took 5 milliseconds Nov 23 13:43:30 volumio volumio[643]: info: sendMpdCommand playlistinfo took 5 milliseconds Nov 23 13:43:30 volumio volumio[643]: info: sendMpdCommand playlistinfo took 5 milliseconds Nov 23 13:43:30 volumio volumio[643]: info: sendMpdCommand playlistinfo took 5 milliseconds Nov 23 13:43:30 volumio volumio[643]: info: sendMpdCommand status took 4 milliseconds Nov 23 13:43:30 volumio volumio[643]: info: sendMpdCommand status took 3 milliseconds Nov 23 13:43:30 volumio volumio[643]: info: sendMpdCommand status took 2 milliseconds Nov 23 13:43:30 volumio volumio[643]: verbose: ControllerMpd::parseState Nov 23 13:43:30 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 23 13:43:30 volumio volumio[643]: verbose: ControllerMpd::parseTrackInfo Nov 23 13:43:30 volumio volumio[643]: verbose: ControllerMpd::parseTrackInfo Nov 23 13:43:30 volumio volumio[643]: verbose: ControllerMpd::parseTrackInfo Nov 23 13:43:30 volumio volumio[643]: verbose: ControllerMpd::parseTrackInfo Nov 23 13:43:30 volumio volumio[643]: verbose: ControllerMpd::parseState Nov 23 13:43:30 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 23 13:43:30 volumio volumio[643]: verbose: ControllerMpd::parseState Nov 23 13:43:30 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 23 13:43:30 volumio volumio[643]: verbose: ControllerMpd::parseState Nov 23 13:43:30 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 23 13:43:30 volumio volumio[643]: info: ControllerMpd::pushState Nov 23 13:43:30 volumio volumio[643]: info: CoreCommandRouter::servicePushState Nov 23 13:43:30 volumio volumio[643]: info: CorePlayQueue::getTrack 302 Nov 23 13:43:30 volumio volumio[643]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":186,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"不挽留没回头","artist":"王小乱","album":"不挽留没回头","uri":"USB/sony/MUSIC/04.抖音流行歌曲980首/不挽留没回头 - 王小乱.mp3","trackType":"mp3"} Nov 23 13:43:30 volumio volumio[643]: verbose: CURRENT POSITION 302 Nov 23 13:43:30 volumio volumio[643]: info: CoreStateMachine::syncState stateService play Nov 23 13:43:30 volumio volumio[643]: info: CoreStateMachine::syncState currentStatus stop Nov 23 13:43:30 volumio volumio[643]: info: ControllerMpd::pushState Nov 23 13:43:30 volumio volumio[643]: info: CoreCommandRouter::servicePushState Nov 23 13:43:30 volumio volumio[643]: info: CorePlayQueue::getTrack 302 Nov 23 13:43:30 volumio volumio[643]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":186,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"不挽留没回头","artist":"王小乱","album":"不挽留没回头","uri":"USB/sony/MUSIC/04.抖音流行歌曲980首/不挽留没回头 - 王小乱.mp3","trackType":"mp3"} Nov 23 13:43:30 volumio volumio[643]: verbose: CURRENT POSITION 302 Nov 23 13:43:30 volumio volumio[643]: info: CoreStateMachine::syncState stateService play Nov 23 13:43:30 volumio volumio[643]: info: CoreStateMachine::syncState currentStatus play Nov 23 13:43:30 volumio volumio[643]: info: Received an update from plugin. extracting info from payload Nov 23 13:43:30 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:43:30 volumio volumio[643]: info: CorePlayQueue::getTrack 302 Nov 23 13:43:30 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 23 13:43:30 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:43:30 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:43:30 volumio volumio[643]: info: CorePlayQueue::getTrack 302 Nov 23 13:43:30 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:43:30 volumio volumio[643]: info: ControllerMpd::pushState Nov 23 13:43:30 volumio volumio[643]: info: CoreCommandRouter::servicePushState Nov 23 13:43:30 volumio volumio[643]: info: CorePlayQueue::getTrack 302 Nov 23 13:43:30 volumio volumio[643]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":186,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"不挽留没回头","artist":"王小乱","album":"不挽留没回头","uri":"USB/sony/MUSIC/04.抖音流行歌曲980首/不挽留没回头 - 王小乱.mp3","trackType":"mp3"} Nov 23 13:43:30 volumio volumio[643]: verbose: CURRENT POSITION 302 Nov 23 13:43:30 volumio volumio[643]: info: CoreStateMachine::syncState stateService play Nov 23 13:43:30 volumio volumio[643]: info: CoreStateMachine::syncState currentStatus play Nov 23 13:43:30 volumio volumio[643]: info: Received an update from plugin. extracting info from payload Nov 23 13:43:30 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:43:30 volumio volumio[643]: info: CorePlayQueue::getTrack 302 Nov 23 13:43:30 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:43:30 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:43:30 volumio volumio[643]: info: CorePlayQueue::getTrack 302 Nov 23 13:43:30 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:43:30 volumio volumio[643]: info: ControllerMpd::pushState Nov 23 13:43:30 volumio volumio[643]: info: CoreCommandRouter::servicePushState Nov 23 13:43:30 volumio volumio[643]: info: CorePlayQueue::getTrack 302 Nov 23 13:43:30 volumio volumio[643]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":186,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"不挽留没回头","artist":"王小乱","album":"不挽留没回头","uri":"USB/sony/MUSIC/04.抖音流行歌曲980首/不挽留没回头 - 王小乱.mp3","trackType":"mp3"} Nov 23 13:43:30 volumio volumio[643]: verbose: CURRENT POSITION 302 Nov 23 13:43:30 volumio volumio[643]: info: CoreStateMachine::syncState stateService play Nov 23 13:43:30 volumio volumio[643]: info: CoreStateMachine::syncState currentStatus play Nov 23 13:43:30 volumio volumio[643]: info: Received an update from plugin. extracting info from payload Nov 23 13:43:30 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:43:30 volumio volumio[643]: info: CorePlayQueue::getTrack 302 Nov 23 13:43:30 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:43:30 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:43:30 volumio volumio[643]: info: CorePlayQueue::getTrack 302 Nov 23 13:43:30 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:43:30 volumio volumio[643]: info: ------------------------------ 31ms Nov 23 13:43:30 volumio volumio[643]: info: ------------------------------ 62ms Nov 23 13:43:30 volumio volumio[643]: info: ------------------------------ 62ms Nov 23 13:43:30 volumio volumio[643]: info: ------------------------------ 62ms Nov 23 13:43:30 volumio volumio[643]: info: sendMpdCommand playlistinfo took 53 milliseconds Nov 23 13:43:30 volumio volumio[643]: info: sendMpdCommand playlistinfo took 54 milliseconds Nov 23 13:43:30 volumio volumio[643]: info: sendMpdCommand playlistinfo took 53 milliseconds Nov 23 13:43:30 volumio volumio[643]: info: sendMpdCommand playlistinfo took 53 milliseconds Nov 23 13:43:30 volumio volumio[643]: verbose: ControllerMpd::parseTrackInfo Nov 23 13:43:30 volumio volumio[643]: verbose: ControllerMpd::parseTrackInfo Nov 23 13:43:30 volumio volumio[643]: verbose: ControllerMpd::parseTrackInfo Nov 23 13:43:30 volumio volumio[643]: info: ControllerMpd::pushState Nov 23 13:43:30 volumio volumio[643]: info: CoreCommandRouter::servicePushState Nov 23 13:43:30 volumio volumio[643]: info: CorePlayQueue::getTrack 302 Nov 23 13:43:30 volumio volumio[643]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":186,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"不挽留没回头","artist":"王小乱","album":"不挽留没回头","uri":"USB/sony/MUSIC/04.抖音流行歌曲980首/不挽留没回头 - 王小乱.mp3","trackType":"mp3"} Nov 23 13:43:30 volumio volumio[643]: verbose: CURRENT POSITION 302 Nov 23 13:43:30 volumio volumio[643]: info: CoreStateMachine::syncState stateService play Nov 23 13:43:30 volumio volumio[643]: info: CoreStateMachine::syncState currentStatus play Nov 23 13:43:30 volumio volumio[643]: info: Received an update from plugin. extracting info from payload Nov 23 13:43:30 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:43:30 volumio volumio[643]: info: CorePlayQueue::getTrack 302 Nov 23 13:43:30 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:43:30 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:43:30 volumio volumio[643]: info: CorePlayQueue::getTrack 302 Nov 23 13:43:30 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:43:30 volumio volumio[643]: info: ControllerMpd::pushState Nov 23 13:43:30 volumio volumio[643]: info: CoreCommandRouter::servicePushState Nov 23 13:43:30 volumio volumio[643]: info: CorePlayQueue::getTrack 302 Nov 23 13:43:30 volumio volumio[643]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":186,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"不挽留没回头","artist":"王小乱","album":"不挽留没回头","uri":"USB/sony/MUSIC/04.抖音流行歌曲980首/不挽留没回头 - 王小乱.mp3","trackType":"mp3"} Nov 23 13:43:30 volumio volumio[643]: verbose: CURRENT POSITION 302 Nov 23 13:43:30 volumio volumio[643]: info: CoreStateMachine::syncState stateService play Nov 23 13:43:30 volumio volumio[643]: info: CoreStateMachine::syncState currentStatus play Nov 23 13:43:30 volumio volumio[643]: info: Received an update from plugin. extracting info from payload Nov 23 13:43:30 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:43:30 volumio volumio[643]: info: CorePlayQueue::getTrack 302 Nov 23 13:43:30 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:43:30 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:43:30 volumio volumio[643]: info: CorePlayQueue::getTrack 302 Nov 23 13:43:30 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:43:30 volumio volumio[643]: info: ControllerMpd::pushState Nov 23 13:43:30 volumio volumio[643]: info: CoreCommandRouter::servicePushState Nov 23 13:43:30 volumio volumio[643]: info: CorePlayQueue::getTrack 302 Nov 23 13:43:30 volumio volumio[643]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":186,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"不挽留没回头","artist":"王小乱","album":"不挽留没回头","uri":"USB/sony/MUSIC/04.抖音流行歌曲980首/不挽留没回头 - 王小乱.mp3","trackType":"mp3"} Nov 23 13:43:30 volumio volumio[643]: verbose: CURRENT POSITION 302 Nov 23 13:43:30 volumio volumio[643]: info: CoreStateMachine::syncState stateService play Nov 23 13:43:30 volumio volumio[643]: info: CoreStateMachine::syncState currentStatus play Nov 23 13:43:30 volumio volumio[643]: info: Received an update from plugin. extracting info from payload Nov 23 13:43:30 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:43:30 volumio volumio[643]: info: CorePlayQueue::getTrack 302 Nov 23 13:43:30 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:43:30 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:43:30 volumio volumio[643]: info: CorePlayQueue::getTrack 302 Nov 23 13:43:30 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:43:30 volumio volumio[643]: info: ControllerMpd::pushState Nov 23 13:43:30 volumio volumio[643]: info: CoreCommandRouter::servicePushState Nov 23 13:43:30 volumio volumio[643]: info: CorePlayQueue::getTrack 302 Nov 23 13:43:30 volumio volumio[643]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":186,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"不挽留没回头","artist":"王小乱","album":"不挽留没回头","uri":"USB/sony/MUSIC/04.抖音流行歌曲980首/不挽留没回头 - 王小乱.mp3","trackType":"mp3"} Nov 23 13:43:30 volumio volumio[643]: verbose: CURRENT POSITION 302 Nov 23 13:43:30 volumio volumio[643]: info: CoreStateMachine::syncState stateService play Nov 23 13:43:30 volumio volumio[643]: info: CoreStateMachine::syncState currentStatus play Nov 23 13:43:30 volumio volumio[643]: info: Received an update from plugin. extracting info from payload Nov 23 13:43:30 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:43:30 volumio volumio[643]: info: CorePlayQueue::getTrack 302 Nov 23 13:43:30 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:43:30 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:43:30 volumio volumio[643]: info: CorePlayQueue::getTrack 302 Nov 23 13:43:30 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:43:30 volumio volumio[643]: info: ------------------------------ 140ms Nov 23 13:43:30 volumio volumio[643]: info: ------------------------------ 137ms Nov 23 13:43:30 volumio volumio[643]: info: ------------------------------ 137ms Nov 23 13:43:30 volumio volumio[643]: info: ------------------------------ 137ms Nov 23 13:43:32 volumio mount.exfat[900]: failed to read cluster 0x8d6ee Nov 23 13:43:32 volumio mount.exfat[900]: failed to read cluster 0x8d6ee Nov 23 13:43:32 volumio kernel: sd 2:0:0:1: [sdc] tag#0 access beyond end of device Nov 23 13:43:32 volumio kernel: I/O error, dev sdc, sector 148368384 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 2 Nov 23 13:43:32 volumio kernel: sd 2:0:0:1: [sdc] tag#0 access beyond end of device Nov 23 13:43:32 volumio kernel: I/O error, dev sdc, sector 148368384 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Nov 23 13:43:32 volumio kernel: Buffer I/O error on dev sdc1, logical block 18541952, async page read Nov 23 13:43:32 volumio kernel: sd 2:0:0:1: [sdc] tag#0 access beyond end of device Nov 23 13:43:32 volumio kernel: I/O error, dev sdc, sector 148368488 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 2 Nov 23 13:43:32 volumio kernel: sd 2:0:0:1: [sdc] tag#0 access beyond end of device Nov 23 13:43:32 volumio kernel: I/O error, dev sdc, sector 148368488 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Nov 23 13:43:32 volumio kernel: Buffer I/O error on dev sdc1, logical block 18541965, async page read Nov 23 13:43:47 volumio mount.exfat[900]: failed to read cluster 0x8d6ef Nov 23 13:43:47 volumio kernel: sd 2:0:0:1: [sdc] tag#0 access beyond end of device Nov 23 13:43:47 volumio kernel: I/O error, dev sdc, sector 148368744 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 2 Nov 23 13:43:47 volumio kernel: sd 2:0:0:1: [sdc] tag#0 access beyond end of device Nov 23 13:43:47 volumio kernel: I/O error, dev sdc, sector 148368744 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Nov 23 13:43:47 volumio kernel: Buffer I/O error on dev sdc1, logical block 18541997, async page read Nov 23 13:43:47 volumio kernel: sd 2:0:0:1: [sdc] tag#0 access beyond end of device Nov 23 13:43:47 volumio kernel: I/O error, dev sdc, sector 148369000 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 2 Nov 23 13:43:47 volumio kernel: sd 2:0:0:1: [sdc] tag#0 access beyond end of device Nov 23 13:43:47 volumio kernel: I/O error, dev sdc, sector 148369000 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Nov 23 13:43:47 volumio kernel: Buffer I/O error on dev sdc1, logical block 18542029, async page read Nov 23 13:43:47 volumio mount.exfat[900]: failed to read cluster 0x8d6f0 Nov 23 13:43:52 volumio mount.exfat[900]: failed to read cluster 0x8d6ee Nov 23 13:43:52 volumio kernel: sd 2:0:0:1: [sdc] tag#0 access beyond end of device Nov 23 13:43:52 volumio kernel: I/O error, dev sdc, sector 148368384 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Nov 23 13:43:52 volumio kernel: Buffer I/O error on dev sdc1, logical block 18541952, async page read Nov 23 13:43:54 volumio mount.exfat[900]: failed to read cluster 0x8d6ee Nov 23 13:43:54 volumio kernel: sd 2:0:0:1: [sdc] tag#0 access beyond end of device Nov 23 13:43:54 volumio kernel: I/O error, dev sdc, sector 148368384 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Nov 23 13:43:54 volumio kernel: Buffer I/O error on dev sdc1, logical block 18541952, async page read Nov 23 13:44:00 volumio volumio[643]: info: Nov 23 13:44:00 volumio volumio[643]: ---------------------------- MPD announces state update: player Nov 23 13:44:00 volumio volumio[643]: info: ControllerMpd::getState Nov 23 13:44:00 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand status Nov 23 13:44:00 volumio volumio[643]: info: Nov 23 13:44:00 volumio volumio[643]: ---------------------------- MPD announces state update: player Nov 23 13:44:00 volumio volumio[643]: info: ControllerMpd::getState Nov 23 13:44:00 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand status Nov 23 13:44:00 volumio volumio[643]: info: Nov 23 13:44:00 volumio volumio[643]: ---------------------------- MPD announces state update: player Nov 23 13:44:00 volumio volumio[643]: info: ControllerMpd::getState Nov 23 13:44:00 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand status Nov 23 13:44:00 volumio volumio[643]: info: Nov 23 13:44:00 volumio volumio[643]: ---------------------------- MPD announces state update: player Nov 23 13:44:00 volumio volumio[643]: info: ControllerMpd::getState Nov 23 13:44:00 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand status Nov 23 13:44:00 volumio volumio[643]: info: sendMpdCommand status took 6 milliseconds Nov 23 13:44:00 volumio volumio[643]: info: sendMpdCommand status took 3 milliseconds Nov 23 13:44:00 volumio volumio[643]: verbose: ControllerMpd::parseState Nov 23 13:44:00 volumio volumio[643]: verbose: ControllerMpd::parseState Nov 23 13:44:00 volumio volumio[643]: info: ControllerMpd::pushState Nov 23 13:44:00 volumio volumio[643]: info: CoreCommandRouter::servicePushState Nov 23 13:44:00 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:44:00 volumio volumio[643]: info: CorePlayQueue::getTrack 302 Nov 23 13:44:00 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 23 13:44:00 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:44:00 volumio volumio[643]: info: CorePlayQueue::getTrack 302 Nov 23 13:44:00 volumio volumio[643]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Nov 23 13:44:00 volumio volumio[643]: verbose: CURRENT POSITION 302 Nov 23 13:44:00 volumio volumio[643]: info: CoreStateMachine::syncState stateService stop Nov 23 13:44:00 volumio volumio[643]: info: CoreStateMachine::syncState currentStatus play Nov 23 13:44:00 volumio volumio[643]: info: CoreStateMachine::play index undefined Nov 23 13:44:00 volumio volumio[643]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 23 13:44:00 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:44:00 volumio volumio[643]: info: CorePlayQueue::getTrack 303 Nov 23 13:44:00 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 23 13:44:00 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:44:00 volumio volumio[643]: info: ControllerMpd::pushState Nov 23 13:44:00 volumio volumio[643]: info: CoreCommandRouter::servicePushState Nov 23 13:44:00 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:44:00 volumio volumio[643]: info: CorePlayQueue::getTrack 303 Nov 23 13:44:00 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:44:00 volumio volumio[643]: info: CorePlayQueue::getTrack 303 Nov 23 13:44:00 volumio volumio[643]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Nov 23 13:44:00 volumio volumio[643]: verbose: CURRENT POSITION 303 Nov 23 13:44:00 volumio volumio[643]: info: CoreStateMachine::syncState stateService stop Nov 23 13:44:00 volumio volumio[643]: info: CoreStateMachine::syncState currentStatus stop Nov 23 13:44:00 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:44:00 volumio volumio[643]: info: CorePlayQueue::getTrack 303 Nov 23 13:44:00 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:44:00 volumio volumio[643]: info: No code Nov 23 13:44:00 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:44:00 volumio volumio[643]: info: CorePlayQueue::getTrack 303 Nov 23 13:44:00 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:44:00 volumio volumio[643]: info: CorePlayQueue::getTrack 303 Nov 23 13:44:00 volumio volumio[643]: info: CoreStateMachine::startPlaybackTimer Nov 23 13:44:00 volumio volumio[643]: info: CorePlayQueue::getTrack 303 Nov 23 13:44:00 volumio volumio[643]: verbose: ControllerMpd::clearAddPlayTracks USB/sony/MUSIC/04.抖音流行歌曲980首/不潮不用花钱 - 林俊杰.mp3 Nov 23 13:44:00 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand stop Nov 23 13:44:00 volumio volumio[643]: info: ------------------------------ 55ms Nov 23 13:44:00 volumio volumio[643]: info: ------------------------------ 54ms Nov 23 13:44:00 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:44:00 volumio volumio[643]: info: CorePlayQueue::getTrack 303 Nov 23 13:44:00 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 23 13:44:00 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:44:00 volumio volumio[643]: info: sendMpdCommand status took 66 milliseconds Nov 23 13:44:00 volumio volumio[643]: info: sendMpdCommand status took 66 milliseconds Nov 23 13:44:00 volumio volumio[643]: info: sendMpdCommand stop took 18 milliseconds Nov 23 13:44:00 volumio volumio[643]: verbose: ControllerMpd::parseState Nov 23 13:44:00 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand clear Nov 23 13:44:00 volumio volumio[643]: info: ControllerMpd::pushState Nov 23 13:44:00 volumio volumio[643]: info: CoreCommandRouter::servicePushState Nov 23 13:44:00 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:44:00 volumio volumio[643]: info: CorePlayQueue::getTrack 303 Nov 23 13:44:00 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:44:00 volumio volumio[643]: info: CorePlayQueue::getTrack 303 Nov 23 13:44:00 volumio volumio[643]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Nov 23 13:44:00 volumio volumio[643]: verbose: CURRENT POSITION 303 Nov 23 13:44:00 volumio volumio[643]: info: CoreStateMachine::syncState stateService stop Nov 23 13:44:00 volumio volumio[643]: info: CoreStateMachine::syncState currentStatus stop Nov 23 13:44:00 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:44:00 volumio volumio[643]: info: CorePlayQueue::getTrack 303 Nov 23 13:44:00 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:44:00 volumio volumio[643]: info: No code Nov 23 13:44:00 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:44:00 volumio volumio[643]: info: CorePlayQueue::getTrack 303 Nov 23 13:44:00 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:44:00 volumio volumio[643]: info: ControllerMpd::pushState Nov 23 13:44:00 volumio volumio[643]: info: CoreCommandRouter::servicePushState Nov 23 13:44:00 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:44:00 volumio volumio[643]: info: CorePlayQueue::getTrack 303 Nov 23 13:44:00 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:44:00 volumio volumio[643]: info: CorePlayQueue::getTrack 303 Nov 23 13:44:00 volumio volumio[643]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Nov 23 13:44:00 volumio volumio[643]: verbose: CURRENT POSITION 303 Nov 23 13:44:00 volumio volumio[643]: info: CoreStateMachine::syncState stateService stop Nov 23 13:44:00 volumio volumio[643]: info: CoreStateMachine::syncState currentStatus stop Nov 23 13:44:00 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:44:00 volumio volumio[643]: info: CorePlayQueue::getTrack 303 Nov 23 13:44:00 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:44:00 volumio volumio[643]: info: No code Nov 23 13:44:00 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:44:00 volumio volumio[643]: info: CorePlayQueue::getTrack 303 Nov 23 13:44:00 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:44:00 volumio volumio[643]: info: ------------------------------ 127ms Nov 23 13:44:00 volumio volumio[643]: info: ------------------------------ 127ms Nov 23 13:44:00 volumio volumio[643]: info: Nov 23 13:44:00 volumio volumio[643]: ---------------------------- MPD announces system playlist update Nov 23 13:44:00 volumio volumio[643]: info: Ignoring MPD Status Update Nov 23 13:44:00 volumio volumio[643]: info: sendMpdCommand clear took 101 milliseconds Nov 23 13:44:00 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand add "USB/sony/MUSIC/04.抖音流行歌曲980首/不潮不用花钱 - 林俊杰.mp3" Nov 23 13:44:00 volumio volumio[643]: info: Nov 23 13:44:00 volumio volumio[643]: ---------------------------- MPD announces system playlist update Nov 23 13:44:00 volumio volumio[643]: info: Ignoring MPD Status Update Nov 23 13:44:00 volumio volumio[643]: info: Nov 23 13:44:00 volumio volumio[643]: ---------------------------- MPD announces system playlist update Nov 23 13:44:00 volumio volumio[643]: info: Ignoring MPD Status Update Nov 23 13:44:00 volumio volumio[643]: info: Nov 23 13:44:00 volumio volumio[643]: ---------------------------- MPD announces system playlist update Nov 23 13:44:00 volumio volumio[643]: info: Ignoring MPD Status Update Nov 23 13:44:00 volumio volumio[643]: error: updateQueue error: null Nov 23 13:44:00 volumio volumio[643]: info: Nov 23 13:44:00 volumio volumio[643]: ---------------------------- MPD announces system playlist update Nov 23 13:44:00 volumio volumio[643]: info: Ignoring MPD Status Update Nov 23 13:44:00 volumio volumio[643]: info: ------------------------------ 13ms Nov 23 13:44:00 volumio volumio[643]: info: sendMpdCommand add "USB/sony/MUSIC/04.抖音流行歌曲980首/不潮不用花钱 - 林俊杰.mp3" took 10 milliseconds Nov 23 13:44:00 volumio volumio[643]: info: ------------------------------ 9ms Nov 23 13:44:00 volumio volumio[643]: info: ------------------------------ 8ms Nov 23 13:44:00 volumio volumio[643]: info: ------------------------------ 7ms Nov 23 13:44:00 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand play Nov 23 13:44:00 volumio volumio[643]: info: Nov 23 13:44:00 volumio volumio[643]: ---------------------------- MPD announces system playlist update Nov 23 13:44:00 volumio volumio[643]: info: Ignoring MPD Status Update Nov 23 13:44:00 volumio volumio[643]: info: Nov 23 13:44:00 volumio volumio[643]: ---------------------------- MPD announces system playlist update Nov 23 13:44:00 volumio volumio[643]: info: Ignoring MPD Status Update Nov 23 13:44:00 volumio volumio[643]: info: Nov 23 13:44:00 volumio volumio[643]: ---------------------------- MPD announces system playlist update Nov 23 13:44:00 volumio volumio[643]: info: Ignoring MPD Status Update Nov 23 13:44:00 volumio volumio[643]: info: ------------------------------ 9ms Nov 23 13:44:00 volumio volumio[643]: info: sendMpdCommand play took 9 milliseconds Nov 23 13:44:00 volumio volumio[643]: info: ------------------------------ 5ms Nov 23 13:44:00 volumio volumio[643]: info: ------------------------------ 4ms Nov 23 13:44:00 volumio volumio[643]: info: ------------------------------ 3ms Nov 23 13:44:00 volumio volumio[643]: info: Nov 23 13:44:00 volumio volumio[643]: ---------------------------- MPD announces state update: player Nov 23 13:44:00 volumio volumio[643]: info: ControllerMpd::getState Nov 23 13:44:00 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand status Nov 23 13:44:00 volumio volumio[643]: info: Nov 23 13:44:00 volumio volumio[643]: ---------------------------- MPD announces state update: player Nov 23 13:44:00 volumio volumio[643]: info: ControllerMpd::getState Nov 23 13:44:00 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand status Nov 23 13:44:00 volumio volumio[643]: info: Nov 23 13:44:00 volumio volumio[643]: ---------------------------- MPD announces state update: player Nov 23 13:44:00 volumio volumio[643]: info: ControllerMpd::getState Nov 23 13:44:00 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand status Nov 23 13:44:00 volumio volumio[643]: info: Nov 23 13:44:00 volumio volumio[643]: ---------------------------- MPD announces state update: player Nov 23 13:44:00 volumio volumio[643]: info: ControllerMpd::getState Nov 23 13:44:00 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand status Nov 23 13:44:00 volumio volumio[643]: info: Nov 23 13:44:00 volumio volumio[643]: ---------------------------- MPD announces state update: player Nov 23 13:44:00 volumio volumio[643]: info: ControllerMpd::getState Nov 23 13:44:00 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand status Nov 23 13:44:00 volumio volumio[643]: info: sendMpdCommand status took 6 milliseconds Nov 23 13:44:00 volumio volumio[643]: info: sendMpdCommand status took 6 milliseconds Nov 23 13:44:00 volumio volumio[643]: info: sendMpdCommand status took 5 milliseconds Nov 23 13:44:00 volumio volumio[643]: info: sendMpdCommand status took 5 milliseconds Nov 23 13:44:00 volumio volumio[643]: verbose: ControllerMpd::parseState Nov 23 13:44:00 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 23 13:44:00 volumio volumio[643]: verbose: ControllerMpd::parseState Nov 23 13:44:00 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 23 13:44:00 volumio volumio[643]: verbose: ControllerMpd::parseState Nov 23 13:44:00 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 23 13:44:00 volumio volumio[643]: verbose: ControllerMpd::parseState Nov 23 13:44:00 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 23 13:44:00 volumio volumio[643]: info: Nov 23 13:44:00 volumio volumio[643]: ---------------------------- MPD announces state update: player Nov 23 13:44:00 volumio volumio[643]: info: ControllerMpd::getState Nov 23 13:44:00 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand status Nov 23 13:44:00 volumio volumio[643]: info: Nov 23 13:44:00 volumio volumio[643]: ---------------------------- MPD announces state update: player Nov 23 13:44:00 volumio volumio[643]: info: ControllerMpd::getState Nov 23 13:44:00 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand status Nov 23 13:44:00 volumio volumio[643]: info: Nov 23 13:44:00 volumio volumio[643]: ---------------------------- MPD announces state update: player Nov 23 13:44:00 volumio volumio[643]: info: ControllerMpd::getState Nov 23 13:44:00 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand status Nov 23 13:44:00 volumio volumio[643]: info: sendMpdCommand status took 10 milliseconds Nov 23 13:44:00 volumio volumio[643]: info: sendMpdCommand playlistinfo took 7 milliseconds Nov 23 13:44:00 volumio volumio[643]: info: sendMpdCommand playlistinfo took 6 milliseconds Nov 23 13:44:00 volumio volumio[643]: info: sendMpdCommand playlistinfo took 7 milliseconds Nov 23 13:44:00 volumio volumio[643]: info: sendMpdCommand playlistinfo took 6 milliseconds Nov 23 13:44:00 volumio volumio[643]: info: sendMpdCommand status took 4 milliseconds Nov 23 13:44:00 volumio volumio[643]: info: sendMpdCommand status took 3 milliseconds Nov 23 13:44:00 volumio volumio[643]: info: sendMpdCommand status took 2 milliseconds Nov 23 13:44:00 volumio volumio[643]: verbose: ControllerMpd::parseState Nov 23 13:44:00 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 23 13:44:00 volumio volumio[643]: verbose: ControllerMpd::parseTrackInfo Nov 23 13:44:00 volumio volumio[643]: verbose: ControllerMpd::parseTrackInfo Nov 23 13:44:00 volumio volumio[643]: verbose: ControllerMpd::parseTrackInfo Nov 23 13:44:00 volumio volumio[643]: verbose: ControllerMpd::parseState Nov 23 13:44:00 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 23 13:44:00 volumio volumio[643]: verbose: ControllerMpd::parseState Nov 23 13:44:00 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 23 13:44:00 volumio volumio[643]: verbose: ControllerMpd::parseState Nov 23 13:44:00 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 23 13:44:00 volumio volumio[643]: info: ControllerMpd::pushState Nov 23 13:44:00 volumio volumio[643]: info: CoreCommandRouter::servicePushState Nov 23 13:44:00 volumio volumio[643]: info: CorePlayQueue::getTrack 303 Nov 23 13:44:00 volumio volumio[643]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":234,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"不潮不用花钱","artist":"林俊杰","album":"JJ陆","uri":"USB/sony/MUSIC/04.抖音流行歌曲980首/不潮不用花钱 - 林俊杰.mp3","trackType":"mp3"} Nov 23 13:44:00 volumio volumio[643]: verbose: CURRENT POSITION 303 Nov 23 13:44:00 volumio volumio[643]: info: CoreStateMachine::syncState stateService play Nov 23 13:44:00 volumio volumio[643]: info: CoreStateMachine::syncState currentStatus stop Nov 23 13:44:00 volumio volumio[643]: info: ControllerMpd::pushState Nov 23 13:44:00 volumio volumio[643]: info: CoreCommandRouter::servicePushState Nov 23 13:44:00 volumio volumio[643]: info: CorePlayQueue::getTrack 303 Nov 23 13:44:00 volumio volumio[643]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":234,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"不潮不用花钱","artist":"林俊杰","album":"JJ陆","uri":"USB/sony/MUSIC/04.抖音流行歌曲980首/不潮不用花钱 - 林俊杰.mp3","trackType":"mp3"} Nov 23 13:44:00 volumio volumio[643]: verbose: CURRENT POSITION 303 Nov 23 13:44:00 volumio volumio[643]: info: CoreStateMachine::syncState stateService play Nov 23 13:44:00 volumio volumio[643]: info: CoreStateMachine::syncState currentStatus play Nov 23 13:44:00 volumio volumio[643]: info: Received an update from plugin. extracting info from payload Nov 23 13:44:00 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:44:00 volumio volumio[643]: info: CorePlayQueue::getTrack 303 Nov 23 13:44:00 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 23 13:44:00 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:44:00 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:44:00 volumio volumio[643]: info: CorePlayQueue::getTrack 303 Nov 23 13:44:00 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:44:00 volumio volumio[643]: info: ControllerMpd::pushState Nov 23 13:44:00 volumio volumio[643]: info: CoreCommandRouter::servicePushState Nov 23 13:44:00 volumio volumio[643]: info: CorePlayQueue::getTrack 303 Nov 23 13:44:00 volumio volumio[643]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":234,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"不潮不用花钱","artist":"林俊杰","album":"JJ陆","uri":"USB/sony/MUSIC/04.抖音流行歌曲980首/不潮不用花钱 - 林俊杰.mp3","trackType":"mp3"} Nov 23 13:44:00 volumio volumio[643]: verbose: CURRENT POSITION 303 Nov 23 13:44:00 volumio volumio[643]: info: CoreStateMachine::syncState stateService play Nov 23 13:44:00 volumio volumio[643]: info: CoreStateMachine::syncState currentStatus play Nov 23 13:44:00 volumio volumio[643]: info: Received an update from plugin. extracting info from payload Nov 23 13:44:00 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:44:00 volumio volumio[643]: info: CorePlayQueue::getTrack 303 Nov 23 13:44:00 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:44:00 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:44:00 volumio volumio[643]: info: CorePlayQueue::getTrack 303 Nov 23 13:44:00 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:44:00 volumio volumio[643]: info: ControllerMpd::pushState Nov 23 13:44:00 volumio volumio[643]: info: CoreCommandRouter::servicePushState Nov 23 13:44:00 volumio volumio[643]: info: CorePlayQueue::getTrack 303 Nov 23 13:44:00 volumio volumio[643]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":234,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"不潮不用花钱","artist":"林俊杰","album":"JJ陆","uri":"USB/sony/MUSIC/04.抖音流行歌曲980首/不潮不用花钱 - 林俊杰.mp3","trackType":"mp3"} Nov 23 13:44:00 volumio volumio[643]: verbose: CURRENT POSITION 303 Nov 23 13:44:00 volumio volumio[643]: info: CoreStateMachine::syncState stateService play Nov 23 13:44:00 volumio volumio[643]: info: CoreStateMachine::syncState currentStatus play Nov 23 13:44:00 volumio volumio[643]: info: Received an update from plugin. extracting info from payload Nov 23 13:44:00 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:44:00 volumio volumio[643]: info: CorePlayQueue::getTrack 303 Nov 23 13:44:00 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:44:00 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:44:00 volumio volumio[643]: info: CorePlayQueue::getTrack 303 Nov 23 13:44:00 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:44:00 volumio volumio[643]: info: ------------------------------ 43ms Nov 23 13:44:00 volumio volumio[643]: info: ------------------------------ 51ms Nov 23 13:44:00 volumio volumio[643]: info: ------------------------------ 50ms Nov 23 13:44:00 volumio volumio[643]: info: ------------------------------ 51ms Nov 23 13:44:00 volumio volumio[643]: info: sendMpdCommand playlistinfo took 37 milliseconds Nov 23 13:44:00 volumio volumio[643]: info: sendMpdCommand playlistinfo took 37 milliseconds Nov 23 13:44:00 volumio volumio[643]: info: sendMpdCommand playlistinfo took 37 milliseconds Nov 23 13:44:00 volumio volumio[643]: info: sendMpdCommand playlistinfo took 36 milliseconds Nov 23 13:44:00 volumio volumio[643]: verbose: ControllerMpd::parseTrackInfo Nov 23 13:44:00 volumio volumio[643]: verbose: ControllerMpd::parseTrackInfo Nov 23 13:44:00 volumio volumio[643]: verbose: ControllerMpd::parseTrackInfo Nov 23 13:44:00 volumio volumio[643]: verbose: ControllerMpd::parseTrackInfo Nov 23 13:44:00 volumio volumio[643]: info: ControllerMpd::pushState Nov 23 13:44:00 volumio volumio[643]: info: CoreCommandRouter::servicePushState Nov 23 13:44:00 volumio volumio[643]: info: CorePlayQueue::getTrack 303 Nov 23 13:44:00 volumio volumio[643]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":234,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"不潮不用花钱","artist":"林俊杰","album":"JJ陆","uri":"USB/sony/MUSIC/04.抖音流行歌曲980首/不潮不用花钱 - 林俊杰.mp3","trackType":"mp3"} Nov 23 13:44:00 volumio volumio[643]: verbose: CURRENT POSITION 303 Nov 23 13:44:00 volumio volumio[643]: info: CoreStateMachine::syncState stateService play Nov 23 13:44:00 volumio volumio[643]: info: CoreStateMachine::syncState currentStatus play Nov 23 13:44:00 volumio volumio[643]: info: Received an update from plugin. extracting info from payload Nov 23 13:44:00 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:44:00 volumio volumio[643]: info: CorePlayQueue::getTrack 303 Nov 23 13:44:00 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:44:00 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:44:00 volumio volumio[643]: info: CorePlayQueue::getTrack 303 Nov 23 13:44:00 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:44:00 volumio volumio[643]: info: ControllerMpd::pushState Nov 23 13:44:00 volumio volumio[643]: info: CoreCommandRouter::servicePushState Nov 23 13:44:00 volumio volumio[643]: info: CorePlayQueue::getTrack 303 Nov 23 13:44:00 volumio volumio[643]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":234,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"不潮不用花钱","artist":"林俊杰","album":"JJ陆","uri":"USB/sony/MUSIC/04.抖音流行歌曲980首/不潮不用花钱 - 林俊杰.mp3","trackType":"mp3"} Nov 23 13:44:00 volumio volumio[643]: verbose: CURRENT POSITION 303 Nov 23 13:44:00 volumio volumio[643]: info: CoreStateMachine::syncState stateService play Nov 23 13:44:00 volumio volumio[643]: info: CoreStateMachine::syncState currentStatus play Nov 23 13:44:00 volumio volumio[643]: info: Received an update from plugin. extracting info from payload Nov 23 13:44:00 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:44:00 volumio volumio[643]: info: CorePlayQueue::getTrack 303 Nov 23 13:44:00 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:44:00 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:44:00 volumio volumio[643]: info: CorePlayQueue::getTrack 303 Nov 23 13:44:00 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:44:00 volumio volumio[643]: info: ControllerMpd::pushState Nov 23 13:44:00 volumio volumio[643]: info: CoreCommandRouter::servicePushState Nov 23 13:44:00 volumio volumio[643]: info: CorePlayQueue::getTrack 303 Nov 23 13:44:00 volumio volumio[643]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":234,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"不潮不用花钱","artist":"林俊杰","album":"JJ陆","uri":"USB/sony/MUSIC/04.抖音流行歌曲980首/不潮不用花钱 - 林俊杰.mp3","trackType":"mp3"} Nov 23 13:44:00 volumio volumio[643]: verbose: CURRENT POSITION 303 Nov 23 13:44:00 volumio volumio[643]: info: CoreStateMachine::syncState stateService play Nov 23 13:44:00 volumio volumio[643]: info: CoreStateMachine::syncState currentStatus play Nov 23 13:44:00 volumio volumio[643]: info: Received an update from plugin. extracting info from payload Nov 23 13:44:00 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:44:00 volumio volumio[643]: info: CorePlayQueue::getTrack 303 Nov 23 13:44:00 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:44:00 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:44:00 volumio volumio[643]: info: CorePlayQueue::getTrack 303 Nov 23 13:44:00 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:44:00 volumio volumio[643]: info: ControllerMpd::pushState Nov 23 13:44:00 volumio volumio[643]: info: CoreCommandRouter::servicePushState Nov 23 13:44:00 volumio volumio[643]: info: CorePlayQueue::getTrack 303 Nov 23 13:44:00 volumio volumio[643]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":234,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"不潮不用花钱","artist":"林俊杰","album":"JJ陆","uri":"USB/sony/MUSIC/04.抖音流行歌曲980首/不潮不用花钱 - 林俊杰.mp3","trackType":"mp3"} Nov 23 13:44:00 volumio volumio[643]: verbose: CURRENT POSITION 303 Nov 23 13:44:00 volumio volumio[643]: info: CoreStateMachine::syncState stateService play Nov 23 13:44:00 volumio volumio[643]: info: CoreStateMachine::syncState currentStatus play Nov 23 13:44:00 volumio volumio[643]: info: Received an update from plugin. extracting info from payload Nov 23 13:44:00 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:44:00 volumio volumio[643]: info: CorePlayQueue::getTrack 303 Nov 23 13:44:00 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:44:00 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:44:00 volumio volumio[643]: info: CorePlayQueue::getTrack 303 Nov 23 13:44:00 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:44:00 volumio volumio[643]: info: ------------------------------ 82ms Nov 23 13:44:00 volumio volumio[643]: info: ------------------------------ 76ms Nov 23 13:44:00 volumio volumio[643]: info: ------------------------------ 76ms Nov 23 13:44:00 volumio volumio[643]: info: ------------------------------ 75ms Nov 23 13:44:02 volumio mount.exfat[900]: failed to read cluster 0x8d706 Nov 23 13:44:02 volumio mount.exfat[900]: failed to read cluster 0x8d706 Nov 23 13:44:02 volumio kernel: sd 2:0:0:1: [sdc] tag#0 access beyond end of device Nov 23 13:44:02 volumio kernel: I/O error, dev sdc, sector 148374528 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 2 Nov 23 13:44:02 volumio kernel: sd 2:0:0:1: [sdc] tag#0 access beyond end of device Nov 23 13:44:02 volumio kernel: I/O error, dev sdc, sector 148374528 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Nov 23 13:44:02 volumio kernel: Buffer I/O error on dev sdc1, logical block 18542720, async page read Nov 23 13:44:02 volumio kernel: sd 2:0:0:1: [sdc] tag#0 access beyond end of device Nov 23 13:44:02 volumio kernel: I/O error, dev sdc, sector 148374648 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 2 Nov 23 13:44:02 volumio kernel: sd 2:0:0:1: [sdc] tag#0 access beyond end of device Nov 23 13:44:02 volumio kernel: I/O error, dev sdc, sector 148374648 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Nov 23 13:44:02 volumio kernel: Buffer I/O error on dev sdc1, logical block 18542735, async page read Nov 23 13:44:02 volumio sudo[5256]: pam_unix(sudo:session): session closed for user root Nov 23 13:44:07 volumio volumio[643]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 23 13:44:07 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Nov 23 13:44:08 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Nov 23 13:44:08 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Nov 23 13:44:08 volumio volumio[643]: info: Received Get System Version Nov 23 13:44:08 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 23 13:44:13 volumio volumio[643]: info: CoreCommandRouter::volumioGetState Nov 23 13:44:13 volumio volumio[643]: info: CorePlayQueue::getTrack 303 Nov 23 13:44:14 volumio sudo[5641]: root : TTY=unknown ; PWD=/data/plugins/user_interface/peppy_screensaver ; USER=root ; COMMAND=/usr/bin/python3 ./screensaver/volumio_peppymeter.py Nov 23 13:44:14 volumio sudo[5641]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 23 13:44:17 volumio mount.exfat[900]: failed to read cluster 0x8d707 Nov 23 13:44:17 volumio kernel: sd 2:0:0:1: [sdc] tag#0 access beyond end of device Nov 23 13:44:17 volumio kernel: I/O error, dev sdc, sector 148374904 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 2 Nov 23 13:44:17 volumio kernel: sd 2:0:0:1: [sdc] tag#0 access beyond end of device Nov 23 13:44:17 volumio kernel: I/O error, dev sdc, sector 148374904 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Nov 23 13:44:17 volumio kernel: Buffer I/O error on dev sdc1, logical block 18542767, async page read Nov 23 13:44:17 volumio kernel: sd 2:0:0:1: [sdc] tag#0 access beyond end of device Nov 23 13:44:17 volumio kernel: I/O error, dev sdc, sector 148375160 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 2 Nov 23 13:44:17 volumio kernel: sd 2:0:0:1: [sdc] tag#0 access beyond end of device Nov 23 13:44:17 volumio kernel: I/O error, dev sdc, sector 148375160 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Nov 23 13:44:17 volumio kernel: Buffer I/O error on dev sdc1, logical block 18542799, async page read Nov 23 13:44:17 volumio mount.exfat[900]: failed to read cluster 0x8d708 Nov 23 13:44:17 volumio volumio[643]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Total Clients: 6 Nov 23 13:44:17 volumio volumio[643]: info: CoreCommandRouter::volumioGetState Nov 23 13:44:17 volumio volumio[643]: info: CorePlayQueue::getTrack 303 Nov 23 13:44:17 volumio sudo[5641]: pam_unix(sudo:session): session closed for user root Nov 23 13:44:22 volumio mount.exfat[900]: failed to read cluster 0x8d706 Nov 23 13:44:22 volumio kernel: sd 2:0:0:1: [sdc] tag#0 access beyond end of device Nov 23 13:44:22 volumio kernel: I/O error, dev sdc, sector 148374528 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Nov 23 13:44:22 volumio kernel: Buffer I/O error on dev sdc1, logical block 18542720, async page read Nov 23 13:44:23 volumio mount.exfat[900]: failed to read cluster 0x8d706 Nov 23 13:44:23 volumio kernel: sd 2:0:0:1: [sdc] tag#0 access beyond end of device Nov 23 13:44:23 volumio kernel: I/O error, dev sdc, sector 148374528 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Nov 23 13:44:23 volumio kernel: Buffer I/O error on dev sdc1, logical block 18542720, async page read Nov 23 13:44:27 volumio volumio[643]: info: CoreCommandRouter::volumioGetState Nov 23 13:44:27 volumio volumio[643]: info: CorePlayQueue::getTrack 303 Nov 23 13:44:28 volumio volumio[643]: info: CoreCommandRouter::volumioGetState Nov 23 13:44:28 volumio volumio[643]: info: CorePlayQueue::getTrack 303 Nov 23 13:44:29 volumio sudo[5714]: root : TTY=unknown ; PWD=/data/plugins/user_interface/peppy_screensaver ; USER=root ; COMMAND=/usr/bin/python3 ./screensaver/volumio_peppymeter.py Nov 23 13:44:29 volumio sudo[5714]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 23 13:44:29 volumio volumio[643]: info: Nov 23 13:44:29 volumio volumio[643]: ---------------------------- MPD announces state update: player Nov 23 13:44:29 volumio volumio[643]: info: ControllerMpd::getState Nov 23 13:44:29 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand status Nov 23 13:44:29 volumio volumio[643]: info: Nov 23 13:44:29 volumio volumio[643]: ---------------------------- MPD announces state update: player Nov 23 13:44:29 volumio volumio[643]: info: ControllerMpd::getState Nov 23 13:44:29 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand status Nov 23 13:44:29 volumio volumio[643]: info: Nov 23 13:44:29 volumio volumio[643]: ---------------------------- MPD announces state update: player Nov 23 13:44:29 volumio volumio[643]: info: ControllerMpd::getState Nov 23 13:44:29 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand status Nov 23 13:44:29 volumio volumio[643]: info: Nov 23 13:44:29 volumio volumio[643]: ---------------------------- MPD announces state update: player Nov 23 13:44:29 volumio volumio[643]: info: ControllerMpd::getState Nov 23 13:44:29 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand status Nov 23 13:44:29 volumio volumio[643]: info: sendMpdCommand status took 6 milliseconds Nov 23 13:44:29 volumio volumio[643]: info: sendMpdCommand status took 4 milliseconds Nov 23 13:44:29 volumio volumio[643]: info: sendMpdCommand status took 3 milliseconds Nov 23 13:44:29 volumio volumio[643]: info: sendMpdCommand status took 2 milliseconds Nov 23 13:44:29 volumio volumio[643]: verbose: ControllerMpd::parseState Nov 23 13:44:29 volumio volumio[643]: verbose: ControllerMpd::parseState Nov 23 13:44:29 volumio volumio[643]: verbose: ControllerMpd::parseState Nov 23 13:44:29 volumio volumio[643]: verbose: ControllerMpd::parseState Nov 23 13:44:29 volumio volumio[643]: info: ControllerMpd::pushState Nov 23 13:44:29 volumio volumio[643]: info: CoreCommandRouter::servicePushState Nov 23 13:44:29 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:44:29 volumio volumio[643]: info: CorePlayQueue::getTrack 303 Nov 23 13:44:29 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 23 13:44:29 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:44:29 volumio volumio[643]: info: CorePlayQueue::getTrack 303 Nov 23 13:44:29 volumio volumio[643]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Nov 23 13:44:29 volumio volumio[643]: verbose: CURRENT POSITION 303 Nov 23 13:44:29 volumio volumio[643]: info: CoreStateMachine::syncState stateService stop Nov 23 13:44:29 volumio volumio[643]: info: CoreStateMachine::syncState currentStatus play Nov 23 13:44:29 volumio volumio[643]: info: CoreStateMachine::play index undefined Nov 23 13:44:29 volumio volumio[643]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 23 13:44:29 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:44:29 volumio volumio[643]: info: CorePlayQueue::getTrack 304 Nov 23 13:44:29 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 23 13:44:29 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:44:29 volumio volumio[643]: info: ControllerMpd::pushState Nov 23 13:44:29 volumio volumio[643]: info: CoreCommandRouter::servicePushState Nov 23 13:44:29 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:44:29 volumio volumio[643]: info: CorePlayQueue::getTrack 304 Nov 23 13:44:29 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:44:29 volumio volumio[643]: info: CorePlayQueue::getTrack 304 Nov 23 13:44:29 volumio volumio[643]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Nov 23 13:44:29 volumio volumio[643]: verbose: CURRENT POSITION 304 Nov 23 13:44:29 volumio volumio[643]: info: CoreStateMachine::syncState stateService stop Nov 23 13:44:29 volumio volumio[643]: info: CoreStateMachine::syncState currentStatus stop Nov 23 13:44:29 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:44:29 volumio volumio[643]: info: CorePlayQueue::getTrack 304 Nov 23 13:44:29 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:44:29 volumio volumio[643]: info: No code Nov 23 13:44:29 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:44:29 volumio volumio[643]: info: CorePlayQueue::getTrack 304 Nov 23 13:44:29 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:44:29 volumio volumio[643]: info: ControllerMpd::pushState Nov 23 13:44:29 volumio volumio[643]: info: CoreCommandRouter::servicePushState Nov 23 13:44:29 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:44:29 volumio volumio[643]: info: CorePlayQueue::getTrack 304 Nov 23 13:44:29 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:44:29 volumio volumio[643]: info: CorePlayQueue::getTrack 304 Nov 23 13:44:29 volumio volumio[643]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Nov 23 13:44:29 volumio volumio[643]: verbose: CURRENT POSITION 304 Nov 23 13:44:29 volumio volumio[643]: info: CoreStateMachine::syncState stateService stop Nov 23 13:44:29 volumio volumio[643]: info: CoreStateMachine::syncState currentStatus stop Nov 23 13:44:29 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:44:29 volumio volumio[643]: info: CorePlayQueue::getTrack 304 Nov 23 13:44:29 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:44:29 volumio volumio[643]: info: No code Nov 23 13:44:29 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:44:29 volumio volumio[643]: info: CorePlayQueue::getTrack 304 Nov 23 13:44:29 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:44:29 volumio volumio[643]: info: ControllerMpd::pushState Nov 23 13:44:29 volumio volumio[643]: info: CoreCommandRouter::servicePushState Nov 23 13:44:29 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:44:29 volumio volumio[643]: info: CorePlayQueue::getTrack 304 Nov 23 13:44:29 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:44:29 volumio volumio[643]: info: CorePlayQueue::getTrack 304 Nov 23 13:44:29 volumio volumio[643]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Nov 23 13:44:29 volumio volumio[643]: verbose: CURRENT POSITION 304 Nov 23 13:44:29 volumio volumio[643]: info: CoreStateMachine::syncState stateService stop Nov 23 13:44:29 volumio volumio[643]: info: CoreStateMachine::syncState currentStatus stop Nov 23 13:44:29 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:44:29 volumio volumio[643]: info: CorePlayQueue::getTrack 304 Nov 23 13:44:29 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:44:29 volumio volumio[643]: info: No code Nov 23 13:44:29 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:44:29 volumio volumio[643]: info: CorePlayQueue::getTrack 304 Nov 23 13:44:29 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:44:29 volumio volumio[643]: info: CorePlayQueue::getTrack 304 Nov 23 13:44:29 volumio volumio[643]: info: CoreStateMachine::startPlaybackTimer Nov 23 13:44:29 volumio volumio[643]: info: CorePlayQueue::getTrack 304 Nov 23 13:44:29 volumio volumio[643]: verbose: ControllerMpd::clearAddPlayTracks USB/sony/MUSIC/04.抖音流行歌曲980首/不知多少秋声 - 小田音乐社、尹昔眠.mp3 Nov 23 13:44:29 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand stop Nov 23 13:44:29 volumio volumio[643]: info: ------------------------------ 50ms Nov 23 13:44:29 volumio volumio[643]: info: ------------------------------ 49ms Nov 23 13:44:29 volumio volumio[643]: info: ------------------------------ 48ms Nov 23 13:44:29 volumio volumio[643]: info: ------------------------------ 47ms Nov 23 13:44:29 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:44:29 volumio volumio[643]: info: CorePlayQueue::getTrack 304 Nov 23 13:44:29 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 23 13:44:29 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:44:29 volumio volumio[643]: info: sendMpdCommand stop took 8 milliseconds Nov 23 13:44:29 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand clear Nov 23 13:44:29 volumio volumio[643]: info: Nov 23 13:44:29 volumio volumio[643]: ---------------------------- MPD announces system playlist update Nov 23 13:44:29 volumio volumio[643]: info: Ignoring MPD Status Update Nov 23 13:44:29 volumio volumio[643]: info: sendMpdCommand clear took 46 milliseconds Nov 23 13:44:29 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand add "USB/sony/MUSIC/04.抖音流行歌曲980首/不知多少秋声 - 小田音乐社、尹昔眠.mp3" Nov 23 13:44:29 volumio volumio[643]: info: Nov 23 13:44:29 volumio volumio[643]: ---------------------------- MPD announces system playlist update Nov 23 13:44:29 volumio volumio[643]: info: Ignoring MPD Status Update Nov 23 13:44:29 volumio volumio[643]: info: Nov 23 13:44:29 volumio volumio[643]: ---------------------------- MPD announces system playlist update Nov 23 13:44:29 volumio volumio[643]: info: Ignoring MPD Status Update Nov 23 13:44:29 volumio volumio[643]: info: Nov 23 13:44:29 volumio volumio[643]: ---------------------------- MPD announces system playlist update Nov 23 13:44:29 volumio volumio[643]: info: Ignoring MPD Status Update Nov 23 13:44:29 volumio volumio[643]: error: updateQueue error: null Nov 23 13:44:29 volumio volumio[643]: info: Nov 23 13:44:29 volumio volumio[643]: ---------------------------- MPD announces system playlist update Nov 23 13:44:29 volumio volumio[643]: info: Ignoring MPD Status Update Nov 23 13:44:29 volumio volumio[643]: info: ------------------------------ 22ms Nov 23 13:44:29 volumio volumio[643]: info: sendMpdCommand add "USB/sony/MUSIC/04.抖音流行歌曲980首/不知多少秋声 - 小田音乐社、尹昔眠.mp3" took 16 milliseconds Nov 23 13:44:29 volumio volumio[643]: info: ------------------------------ 15ms Nov 23 13:44:29 volumio volumio[643]: info: ------------------------------ 13ms Nov 23 13:44:29 volumio volumio[643]: info: ------------------------------ 8ms Nov 23 13:44:29 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand play Nov 23 13:44:29 volumio volumio[643]: info: Nov 23 13:44:29 volumio volumio[643]: ---------------------------- MPD announces system playlist update Nov 23 13:44:29 volumio volumio[643]: info: Ignoring MPD Status Update Nov 23 13:44:29 volumio volumio[643]: info: Nov 23 13:44:29 volumio volumio[643]: ---------------------------- MPD announces system playlist update Nov 23 13:44:29 volumio volumio[643]: info: Ignoring MPD Status Update Nov 23 13:44:29 volumio volumio[643]: info: Nov 23 13:44:29 volumio volumio[643]: ---------------------------- MPD announces system playlist update Nov 23 13:44:29 volumio volumio[643]: info: Ignoring MPD Status Update Nov 23 13:44:29 volumio volumio[643]: info: Nov 23 13:44:29 volumio volumio[643]: ---------------------------- MPD announces state update: player Nov 23 13:44:29 volumio volumio[643]: info: Nov 23 13:44:29 volumio volumio[643]: ---------------------------- MPD announces state update: player Nov 23 13:44:29 volumio volumio[643]: info: ------------------------------ 26ms Nov 23 13:44:29 volumio volumio[643]: info: sendMpdCommand play took 20 milliseconds Nov 23 13:44:29 volumio volumio[643]: info: ControllerMpd::getState Nov 23 13:44:29 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand status Nov 23 13:44:29 volumio volumio[643]: info: ------------------------------ 20ms Nov 23 13:44:29 volumio volumio[643]: info: ------------------------------ 14ms Nov 23 13:44:29 volumio volumio[643]: info: ControllerMpd::getState Nov 23 13:44:29 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand status Nov 23 13:44:29 volumio mount.exfat[900]: failed to read cluster 0x8d721 Nov 23 13:44:29 volumio mount.exfat[900]: failed to read cluster 0x8d721 Nov 23 13:44:29 volumio kernel: sd 2:0:0:1: [sdc] tag#0 access beyond end of device Nov 23 13:44:29 volumio kernel: I/O error, dev sdc, sector 148381440 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 2 Nov 23 13:44:29 volumio kernel: sd 2:0:0:1: [sdc] tag#0 access beyond end of device Nov 23 13:44:29 volumio kernel: I/O error, dev sdc, sector 148381440 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Nov 23 13:44:29 volumio kernel: Buffer I/O error on dev sdc1, logical block 18543584, async page read Nov 23 13:44:29 volumio kernel: sd 2:0:0:1: [sdc] tag#0 access beyond end of device Nov 23 13:44:29 volumio kernel: I/O error, dev sdc, sector 148381520 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 2 Nov 23 13:44:29 volumio kernel: sd 2:0:0:1: [sdc] tag#0 access beyond end of device Nov 23 13:44:29 volumio kernel: I/O error, dev sdc, sector 148381520 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Nov 23 13:44:29 volumio kernel: Buffer I/O error on dev sdc1, logical block 18543594, async page read Nov 23 13:44:29 volumio volumio[643]: info: sendMpdCommand status took 142 milliseconds Nov 23 13:44:29 volumio volumio[643]: info: sendMpdCommand status took 142 milliseconds Nov 23 13:44:29 volumio volumio[643]: verbose: ControllerMpd::parseState Nov 23 13:44:29 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 23 13:44:29 volumio volumio[643]: verbose: ControllerMpd::parseState Nov 23 13:44:29 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 23 13:44:29 volumio volumio[643]: info: Nov 23 13:44:29 volumio volumio[643]: ---------------------------- MPD announces state update: player Nov 23 13:44:29 volumio volumio[643]: info: ControllerMpd::getState Nov 23 13:44:29 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand status Nov 23 13:44:29 volumio volumio[643]: info: Nov 23 13:44:29 volumio volumio[643]: ---------------------------- MPD announces state update: player Nov 23 13:44:29 volumio volumio[643]: info: ControllerMpd::getState Nov 23 13:44:29 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand status Nov 23 13:44:29 volumio volumio[643]: info: Nov 23 13:44:29 volumio volumio[643]: ---------------------------- MPD announces state update: player Nov 23 13:44:29 volumio volumio[643]: info: ControllerMpd::getState Nov 23 13:44:29 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand status Nov 23 13:44:29 volumio volumio[643]: info: sendMpdCommand playlistinfo took 9 milliseconds Nov 23 13:44:29 volumio volumio[643]: info: sendMpdCommand playlistinfo took 8 milliseconds Nov 23 13:44:29 volumio volumio[643]: info: sendMpdCommand status took 6 milliseconds Nov 23 13:44:29 volumio volumio[643]: info: sendMpdCommand status took 4 milliseconds Nov 23 13:44:29 volumio volumio[643]: info: sendMpdCommand status took 3 milliseconds Nov 23 13:44:29 volumio volumio[643]: verbose: ControllerMpd::parseTrackInfo Nov 23 13:44:29 volumio volumio[643]: verbose: ControllerMpd::parseTrackInfo Nov 23 13:44:29 volumio volumio[643]: verbose: ControllerMpd::parseState Nov 23 13:44:29 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 23 13:44:29 volumio volumio[643]: verbose: ControllerMpd::parseState Nov 23 13:44:29 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 23 13:44:29 volumio volumio[643]: verbose: ControllerMpd::parseState Nov 23 13:44:29 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 23 13:44:29 volumio volumio[643]: info: ControllerMpd::pushState Nov 23 13:44:29 volumio volumio[643]: info: CoreCommandRouter::servicePushState Nov 23 13:44:29 volumio volumio[643]: info: CorePlayQueue::getTrack 304 Nov 23 13:44:29 volumio volumio[643]: verbose: STATE SERVICE {"status":"play","position":0,"seek":193,"duration":181,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"不知多少秋声","artist":"小田音乐社、尹昔眠","album":"不知多少秋声","uri":"USB/sony/MUSIC/04.抖音流行歌曲980首/不知多少秋声 - 小田音乐社、尹昔眠.mp3","trackType":"mp3"} Nov 23 13:44:29 volumio volumio[643]: verbose: CURRENT POSITION 304 Nov 23 13:44:29 volumio volumio[643]: info: CoreStateMachine::syncState stateService play Nov 23 13:44:29 volumio volumio[643]: info: CoreStateMachine::syncState currentStatus stop Nov 23 13:44:29 volumio volumio[643]: info: ControllerMpd::pushState Nov 23 13:44:29 volumio volumio[643]: info: CoreCommandRouter::servicePushState Nov 23 13:44:29 volumio volumio[643]: info: CorePlayQueue::getTrack 304 Nov 23 13:44:29 volumio volumio[643]: verbose: STATE SERVICE {"status":"play","position":0,"seek":204,"duration":181,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"不知多少秋声","artist":"小田音乐社、尹昔眠","album":"不知多少秋声","uri":"USB/sony/MUSIC/04.抖音流行歌曲980首/不知多少秋声 - 小田音乐社、尹昔眠.mp3","trackType":"mp3"} Nov 23 13:44:29 volumio volumio[643]: verbose: CURRENT POSITION 304 Nov 23 13:44:29 volumio volumio[643]: info: CoreStateMachine::syncState stateService play Nov 23 13:44:29 volumio volumio[643]: info: CoreStateMachine::syncState currentStatus play Nov 23 13:44:29 volumio volumio[643]: info: Received an update from plugin. extracting info from payload Nov 23 13:44:29 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:44:29 volumio volumio[643]: info: CorePlayQueue::getTrack 304 Nov 23 13:44:29 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 23 13:44:29 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:44:29 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:44:29 volumio volumio[643]: info: CorePlayQueue::getTrack 304 Nov 23 13:44:29 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:44:29 volumio volumio[643]: info: ------------------------------ 165ms Nov 23 13:44:29 volumio volumio[643]: info: ------------------------------ 168ms Nov 23 13:44:29 volumio volumio[643]: info: Nov 23 13:44:29 volumio volumio[643]: ---------------------------- MPD announces state update: player Nov 23 13:44:29 volumio volumio[643]: info: ControllerMpd::getState Nov 23 13:44:29 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand status Nov 23 13:44:29 volumio volumio[643]: info: Nov 23 13:44:29 volumio volumio[643]: ---------------------------- MPD announces state update: player Nov 23 13:44:29 volumio volumio[643]: info: ControllerMpd::getState Nov 23 13:44:29 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand status Nov 23 13:44:29 volumio volumio[643]: info: Nov 23 13:44:29 volumio volumio[643]: ---------------------------- MPD announces state update: player Nov 23 13:44:29 volumio volumio[643]: info: ControllerMpd::getState Nov 23 13:44:29 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand status Nov 23 13:44:29 volumio volumio[643]: info: sendMpdCommand playlistinfo took 16 milliseconds Nov 23 13:44:29 volumio volumio[643]: info: sendMpdCommand playlistinfo took 17 milliseconds Nov 23 13:44:29 volumio volumio[643]: info: sendMpdCommand status took 5 milliseconds Nov 23 13:44:29 volumio volumio[643]: info: sendMpdCommand status took 3 milliseconds Nov 23 13:44:29 volumio volumio[643]: info: sendMpdCommand status took 4 milliseconds Nov 23 13:44:29 volumio volumio[643]: verbose: ControllerMpd::parseTrackInfo Nov 23 13:44:29 volumio volumio[643]: verbose: ControllerMpd::parseTrackInfo Nov 23 13:44:29 volumio volumio[643]: verbose: ControllerMpd::parseTrackInfo Nov 23 13:44:29 volumio volumio[643]: verbose: ControllerMpd::parseState Nov 23 13:44:29 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 23 13:44:29 volumio volumio[643]: verbose: ControllerMpd::parseState Nov 23 13:44:29 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 23 13:44:29 volumio volumio[643]: verbose: ControllerMpd::parseState Nov 23 13:44:29 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 23 13:44:29 volumio volumio[643]: info: ControllerMpd::pushState Nov 23 13:44:29 volumio volumio[643]: info: CoreCommandRouter::servicePushState Nov 23 13:44:29 volumio volumio[643]: info: CorePlayQueue::getTrack 304 Nov 23 13:44:29 volumio volumio[643]: verbose: STATE SERVICE {"status":"play","position":0,"seek":819,"duration":181,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"不知多少秋声","artist":"小田音乐社、尹昔眠","album":"不知多少秋声","uri":"USB/sony/MUSIC/04.抖音流行歌曲980首/不知多少秋声 - 小田音乐社、尹昔眠.mp3","trackType":"mp3"} Nov 23 13:44:29 volumio volumio[643]: verbose: CURRENT POSITION 304 Nov 23 13:44:29 volumio volumio[643]: info: CoreStateMachine::syncState stateService play Nov 23 13:44:29 volumio volumio[643]: info: CoreStateMachine::syncState currentStatus play Nov 23 13:44:29 volumio volumio[643]: info: Received an update from plugin. extracting info from payload Nov 23 13:44:29 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:44:29 volumio volumio[643]: info: CorePlayQueue::getTrack 304 Nov 23 13:44:29 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 23 13:44:29 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:44:29 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:44:29 volumio volumio[643]: info: CorePlayQueue::getTrack 304 Nov 23 13:44:29 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:44:29 volumio volumio[643]: info: ControllerMpd::pushState Nov 23 13:44:29 volumio volumio[643]: info: CoreCommandRouter::servicePushState Nov 23 13:44:29 volumio volumio[643]: info: CorePlayQueue::getTrack 304 Nov 23 13:44:29 volumio volumio[643]: verbose: STATE SERVICE {"status":"play","position":0,"seek":819,"duration":181,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"不知多少秋声","artist":"小田音乐社、尹昔眠","album":"不知多少秋声","uri":"USB/sony/MUSIC/04.抖音流行歌曲980首/不知多少秋声 - 小田音乐社、尹昔眠.mp3","trackType":"mp3"} Nov 23 13:44:29 volumio volumio[643]: verbose: CURRENT POSITION 304 Nov 23 13:44:29 volumio volumio[643]: info: CoreStateMachine::syncState stateService play Nov 23 13:44:29 volumio volumio[643]: info: CoreStateMachine::syncState currentStatus play Nov 23 13:44:29 volumio volumio[643]: info: Received an update from plugin. extracting info from payload Nov 23 13:44:29 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:44:29 volumio volumio[643]: info: CorePlayQueue::getTrack 304 Nov 23 13:44:29 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:44:29 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:44:29 volumio volumio[643]: info: CorePlayQueue::getTrack 304 Nov 23 13:44:29 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:44:29 volumio volumio[643]: info: ControllerMpd::pushState Nov 23 13:44:29 volumio volumio[643]: info: CoreCommandRouter::servicePushState Nov 23 13:44:29 volumio volumio[643]: info: CorePlayQueue::getTrack 304 Nov 23 13:44:29 volumio volumio[643]: verbose: STATE SERVICE {"status":"play","position":0,"seek":819,"duration":181,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"不知多少秋声","artist":"小田音乐社、尹昔眠","album":"不知多少秋声","uri":"USB/sony/MUSIC/04.抖音流行歌曲980首/不知多少秋声 - 小田音乐社、尹昔眠.mp3","trackType":"mp3"} Nov 23 13:44:29 volumio volumio[643]: verbose: CURRENT POSITION 304 Nov 23 13:44:29 volumio volumio[643]: info: CoreStateMachine::syncState stateService play Nov 23 13:44:29 volumio volumio[643]: info: CoreStateMachine::syncState currentStatus play Nov 23 13:44:29 volumio volumio[643]: info: Received an update from plugin. extracting info from payload Nov 23 13:44:29 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:44:29 volumio volumio[643]: info: CorePlayQueue::getTrack 304 Nov 23 13:44:29 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:44:29 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:44:29 volumio volumio[643]: info: CorePlayQueue::getTrack 304 Nov 23 13:44:29 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:44:29 volumio volumio[643]: info: ------------------------------ 60ms Nov 23 13:44:29 volumio volumio[643]: info: ------------------------------ 59ms Nov 23 13:44:29 volumio volumio[643]: info: ------------------------------ 58ms Nov 23 13:44:29 volumio volumio[643]: info: sendMpdCommand playlistinfo took 57 milliseconds Nov 23 13:44:29 volumio volumio[643]: info: sendMpdCommand playlistinfo took 58 milliseconds Nov 23 13:44:29 volumio volumio[643]: info: sendMpdCommand playlistinfo took 58 milliseconds Nov 23 13:44:29 volumio volumio[643]: verbose: ControllerMpd::parseTrackInfo Nov 23 13:44:29 volumio volumio[643]: verbose: ControllerMpd::parseTrackInfo Nov 23 13:44:29 volumio volumio[643]: verbose: ControllerMpd::parseTrackInfo Nov 23 13:44:29 volumio volumio[643]: info: ControllerMpd::pushState Nov 23 13:44:29 volumio volumio[643]: info: CoreCommandRouter::servicePushState Nov 23 13:44:29 volumio volumio[643]: info: CorePlayQueue::getTrack 304 Nov 23 13:44:29 volumio volumio[643]: verbose: STATE SERVICE {"status":"play","position":0,"seek":819,"duration":181,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"不知多少秋声","artist":"小田音乐社、尹昔眠","album":"不知多少秋声","uri":"USB/sony/MUSIC/04.抖音流行歌曲980首/不知多少秋声 - 小田音乐社、尹昔眠.mp3","trackType":"mp3"} Nov 23 13:44:29 volumio volumio[643]: verbose: CURRENT POSITION 304 Nov 23 13:44:29 volumio volumio[643]: info: CoreStateMachine::syncState stateService play Nov 23 13:44:29 volumio volumio[643]: info: CoreStateMachine::syncState currentStatus play Nov 23 13:44:29 volumio volumio[643]: info: Received an update from plugin. extracting info from payload Nov 23 13:44:29 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:44:29 volumio volumio[643]: info: CorePlayQueue::getTrack 304 Nov 23 13:44:29 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:44:29 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:44:29 volumio volumio[643]: info: CorePlayQueue::getTrack 304 Nov 23 13:44:29 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:44:29 volumio volumio[643]: info: ControllerMpd::pushState Nov 23 13:44:29 volumio volumio[643]: info: CoreCommandRouter::servicePushState Nov 23 13:44:29 volumio volumio[643]: info: CorePlayQueue::getTrack 304 Nov 23 13:44:29 volumio volumio[643]: verbose: STATE SERVICE {"status":"play","position":0,"seek":819,"duration":181,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"不知多少秋声","artist":"小田音乐社、尹昔眠","album":"不知多少秋声","uri":"USB/sony/MUSIC/04.抖音流行歌曲980首/不知多少秋声 - 小田音乐社、尹昔眠.mp3","trackType":"mp3"} Nov 23 13:44:29 volumio volumio[643]: verbose: CURRENT POSITION 304 Nov 23 13:44:29 volumio volumio[643]: info: CoreStateMachine::syncState stateService play Nov 23 13:44:29 volumio volumio[643]: info: CoreStateMachine::syncState currentStatus play Nov 23 13:44:29 volumio volumio[643]: info: Received an update from plugin. extracting info from payload Nov 23 13:44:29 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:44:29 volumio volumio[643]: info: CorePlayQueue::getTrack 304 Nov 23 13:44:29 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:44:29 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:44:29 volumio volumio[643]: info: CorePlayQueue::getTrack 304 Nov 23 13:44:29 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:44:29 volumio volumio[643]: info: ControllerMpd::pushState Nov 23 13:44:29 volumio volumio[643]: info: CoreCommandRouter::servicePushState Nov 23 13:44:29 volumio volumio[643]: info: CorePlayQueue::getTrack 304 Nov 23 13:44:29 volumio volumio[643]: verbose: STATE SERVICE {"status":"play","position":0,"seek":819,"duration":181,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"不知多少秋声","artist":"小田音乐社、尹昔眠","album":"不知多少秋声","uri":"USB/sony/MUSIC/04.抖音流行歌曲980首/不知多少秋声 - 小田音乐社、尹昔眠.mp3","trackType":"mp3"} Nov 23 13:44:29 volumio volumio[643]: verbose: CURRENT POSITION 304 Nov 23 13:44:29 volumio volumio[643]: info: CoreStateMachine::syncState stateService play Nov 23 13:44:29 volumio volumio[643]: info: CoreStateMachine::syncState currentStatus play Nov 23 13:44:29 volumio volumio[643]: info: Received an update from plugin. extracting info from payload Nov 23 13:44:29 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:44:29 volumio volumio[643]: info: CorePlayQueue::getTrack 304 Nov 23 13:44:29 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:44:29 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:44:29 volumio volumio[643]: info: CorePlayQueue::getTrack 304 Nov 23 13:44:29 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:44:29 volumio volumio[643]: info: ------------------------------ 88ms Nov 23 13:44:29 volumio volumio[643]: info: ------------------------------ 88ms Nov 23 13:44:29 volumio volumio[643]: info: ------------------------------ 87ms Nov 23 13:44:31 volumio mount.exfat[900]: failed to read cluster 0x8d722 Nov 23 13:44:31 volumio mount.exfat[900]: failed to read cluster 0x8d723 Nov 23 13:44:31 volumio kernel: sd 2:0:0:1: [sdc] tag#0 access beyond end of device Nov 23 13:44:31 volumio kernel: I/O error, dev sdc, sector 148381776 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 2 Nov 23 13:44:31 volumio kernel: sd 2:0:0:1: [sdc] tag#0 access beyond end of device Nov 23 13:44:31 volumio kernel: I/O error, dev sdc, sector 148381776 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Nov 23 13:44:31 volumio kernel: Buffer I/O error on dev sdc1, logical block 18543626, async page read Nov 23 13:44:31 volumio kernel: sd 2:0:0:1: [sdc] tag#0 access beyond end of device Nov 23 13:44:31 volumio kernel: I/O error, dev sdc, sector 148382032 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 2 Nov 23 13:44:31 volumio kernel: sd 2:0:0:1: [sdc] tag#0 access beyond end of device Nov 23 13:44:31 volumio kernel: I/O error, dev sdc, sector 148382032 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Nov 23 13:44:31 volumio kernel: Buffer I/O error on dev sdc1, logical block 18543658, async page read Nov 23 13:44:31 volumio kernel: python3[5742]: segfault at 7f36a7cc6130 ip 00007f36a7cc6130 sp 00007f36adbaf098 error 15 likely on CPU 1 (core 1, socket 0) Nov 23 13:44:31 volumio kernel: Code: 00 00 02 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 25 00 00 00 00 00 00 00 90 36 ad bb 36 7f 00 00 00 00 00 00 00 00 00 00 <00> 00 00 00 00 00 00 00 11 04 00 00 00 00 00 00 e0 7a 0d a8 36 7f Nov 23 13:44:31 volumio sudo[5714]: pam_unix(sudo:session): session closed for user root Nov 23 13:44:31 volumio screensaver.sh[493]: /home/volumio/PeppyMeter/screensaver.sh: line 24: 5714 Segmentation fault sudo python3 ./screensaver/volumio_peppymeter.py Nov 23 13:44:35 volumio volumio[643]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 23 13:44:35 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Nov 23 13:44:35 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 23 13:44:35 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 23 13:44:35 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 23 13:44:35 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 23 13:44:35 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 23 13:44:35 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 23 13:44:35 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Nov 23 13:44:35 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 23 13:44:36 volumio mount.exfat[900]: failed to read cluster 0x8d721 Nov 23 13:44:36 volumio kernel: sd 2:0:0:1: [sdc] tag#0 access beyond end of device Nov 23 13:44:36 volumio kernel: I/O error, dev sdc, sector 148381440 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Nov 23 13:44:36 volumio kernel: Buffer I/O error on dev sdc1, logical block 18543584, async page read Nov 23 13:44:37 volumio mount.exfat[900]: failed to read cluster 0x8d721 Nov 23 13:44:37 volumio kernel: sd 2:0:0:1: [sdc] tag#0 access beyond end of device Nov 23 13:44:37 volumio kernel: I/O error, dev sdc, sector 148381440 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Nov 23 13:44:37 volumio kernel: Buffer I/O error on dev sdc1, logical block 18543584, async page read Nov 23 13:44:42 volumio volumio[643]: info: CoreCommandRouter::volumioGetState Nov 23 13:44:42 volumio volumio[643]: info: CorePlayQueue::getTrack 304 Nov 23 13:44:42 volumio sudo[5775]: root : TTY=unknown ; PWD=/data/plugins/user_interface/peppy_screensaver ; USER=root ; COMMAND=/usr/bin/python3 ./screensaver/volumio_peppymeter.py Nov 23 13:44:42 volumio sudo[5775]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 23 13:44:43 volumio volumio[643]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Nov 23 13:44:43 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Nov 23 13:44:43 volumio volumio[643]: info: Preparing to save Alsa Options, stopping services first Nov 23 13:44:43 volumio volumio[643]: info: CoreCommandRouter::volumioGetState Nov 23 13:44:43 volumio volumio[643]: info: CorePlayQueue::getTrack 304 Nov 23 13:44:43 volumio volumio[643]: info: CoreCommandRouter::volumioPause Nov 23 13:44:43 volumio volumio[643]: info: CoreStateMachine::pause Nov 23 13:44:43 volumio volumio[643]: info: CoreStateMachine::stPlaybackTimer Nov 23 13:44:43 volumio volumio[643]: info: CoreStateMachine::servicePause Nov 23 13:44:43 volumio volumio[643]: info: CorePlayQueue::getTrack 304 Nov 23 13:44:43 volumio volumio[643]: info: CoreCommandRouter::servicePause Nov 23 13:44:43 volumio volumio[643]: info: ControllerMpd::pause Nov 23 13:44:43 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand pause Nov 23 13:44:43 volumio volumio[643]: info: Saving Audio Output to: {"output_device":{"value":"0,0","label":"Analog Out"}} Nov 23 13:44:43 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 23 13:44:43 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 23 13:44:43 volumio volumio[643]: info: Found match in Cards Database: setting mixer for card Analog Out Nov 23 13:44:43 volumio volumio[643]: info: Setting mixer Master for card Analog Out Nov 23 13:44:43 volumio volumio[643]: info: CoreCommandRouter::volumioUpdateVolumeSettings Nov 23 13:44:43 volumio volumio[643]: info: Updating Volume Controller Parameters: Device: 0,0 Name: Analog Out Mixer: Master Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Nov 23 13:44:43 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Nov 23 13:44:43 volumio volumio[643]: info: Disabling external Volume Control Nov 23 13:44:43 volumio volumio[643]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 23 13:44:43 volumio volumio[643]: info: Preparing to generate the ALSA configuration file Nov 23 13:44:43 volumio volumio[643]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Nov 23 13:44:43 volumio volumio[643]: info: Reading ALSA contributions from plugins. Nov 23 13:44:43 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Nov 23 13:44:43 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 23 13:44:43 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 23 13:44:43 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 23 13:44:43 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 23 13:44:43 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 23 13:44:43 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 23 13:44:43 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 23 13:44:43 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 23 13:44:43 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 23 13:44:43 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Nov 23 13:44:43 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 23 13:44:43 volumio volumio[643]: info: VolumeController:: Volume=64 Mute =false Nov 23 13:44:43 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:44:43 volumio volumio[643]: info: CorePlayQueue::getTrack 304 Nov 23 13:44:43 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 23 13:44:43 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:44:43 volumio volumio[643]: info: Asound.conf file written Nov 23 13:44:43 volumio sudo[5792]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Nov 23 13:44:43 volumio sudo[5792]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 23 13:44:43 volumio sudo[5792]: pam_unix(sudo:session): session closed for user root Nov 23 13:44:43 volumio volumio[643]: info: Output device has changed, restarting MPD Nov 23 13:44:43 volumio volumio[643]: info: Output device has changed, restarting Shairport Sync Nov 23 13:44:43 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 23 13:44:43 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 23 13:44:43 volumio sudo[5797]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 23 13:44:43 volumio sudo[5797]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 23 13:44:43 volumio sudo[5797]: pam_unix(sudo:session): session closed for user root Nov 23 13:44:43 volumio sudo[5799]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 23 13:44:43 volumio sudo[5799]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 23 13:44:43 volumio volumio[643]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 23 13:44:43 volumio volumio[643]: info: Output device has changed, restarting MPD Nov 23 13:44:43 volumio systemd[1]: Stopping Music Player Daemon... Nov 23 13:44:43 volumio volumio[643]: info: Output device has changed, restarting Shairport Sync Nov 23 13:44:43 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 23 13:44:43 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 23 13:44:43 volumio sudo[5806]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 23 13:44:43 volumio sudo[5806]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 23 13:44:43 volumio sudo[5808]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 23 13:44:43 volumio sudo[5808]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 23 13:44:43 volumio sudo[5806]: pam_unix(sudo:session): session closed for user root Nov 23 13:44:43 volumio volumio[643]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 23 13:44:43 volumio volumio[643]: info: Nov 23 13:44:43 volumio volumio[643]: ---------------------------- MPD announces state update: player Nov 23 13:44:43 volumio volumio[643]: info: sendMpdCommand pause took 655 milliseconds Nov 23 13:44:43 volumio volumio[643]: info: ControllerMpd::getState Nov 23 13:44:43 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand status Nov 23 13:44:43 volumio volumio[643]: error: MPD error: Error: write EPIPE Nov 23 13:44:43 volumio volumio[643]: error: write EPIPE {"errno":-32,"code":"EPIPE","syscall":"write"} Nov 23 13:44:43 volumio volumio[643]: info: Nov 23 13:44:43 volumio volumio[643]: ---------------------------- MPD announces state update: player Nov 23 13:44:43 volumio volumio[643]: info: ControllerMpd::getState Nov 23 13:44:43 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand status Nov 23 13:44:43 volumio volumio[643]: error: MPD error: Error: write EPIPE Nov 23 13:44:43 volumio volumio[643]: error: write EPIPE {"errno":-32,"code":"EPIPE","syscall":"write"} Nov 23 13:44:43 volumio volumio[643]: info: Nov 23 13:44:43 volumio volumio[643]: ---------------------------- MPD announces state update: player Nov 23 13:44:43 volumio volumio[643]: info: ControllerMpd::getState Nov 23 13:44:43 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand status Nov 23 13:44:43 volumio volumio[643]: error: MPD error: Error: write EPIPE Nov 23 13:44:43 volumio volumio[643]: error: write EPIPE {"errno":-32,"code":"EPIPE","syscall":"write"} Nov 23 13:44:43 volumio volumio[643]: info: Nov 23 13:44:43 volumio volumio[643]: ---------------------------- MPD announces state update: player Nov 23 13:44:43 volumio volumio[643]: info: ControllerMpd::getState Nov 23 13:44:43 volumio volumio[643]: verbose: ControllerMpd::sendMpdCommand status Nov 23 13:44:43 volumio volumio[643]: error: MPD error: Error: write EPIPE Nov 23 13:44:43 volumio volumio[643]: error: write EPIPE {"errno":-32,"code":"EPIPE","syscall":"write"} Nov 23 13:44:43 volumio volumio[643]: info: MPD Permissions set Nov 23 13:44:43 volumio volumio[643]: info: MPD Permissions set Nov 23 13:44:43 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 23 13:44:43 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 23 13:44:43 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 23 13:44:43 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 23 13:44:43 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 23 13:44:43 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Nov 23 13:44:43 volumio systemd[1]: mpd.service: Succeeded. Nov 23 13:44:43 volumio systemd[1]: Stopped Music Player Daemon. Nov 23 13:44:43 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 23 13:44:43 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 23 13:44:43 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 23 13:44:43 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 23 13:44:43 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 23 13:44:43 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 23 13:44:43 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 23 13:44:43 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 23 13:44:43 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 23 13:44:43 volumio systemd[1]: Starting Music Player Daemon... Nov 23 13:44:43 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 23 13:44:43 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Nov 23 13:44:43 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 23 13:44:43 volumio volumio[643]: info: Starting Shairport Sync Nov 23 13:44:44 volumio volumio[643]: info: Starting Shairport Sync Nov 23 13:44:44 volumio sudo[5828]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 23 13:44:44 volumio sudo[5828]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 23 13:44:44 volumio sudo[5830]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 23 13:44:44 volumio sudo[5830]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 23 13:44:44 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 23 13:44:44 volumio systemd[1]: shairport-sync.service: Succeeded. Nov 23 13:44:44 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 23 13:44:44 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 23 13:44:44 volumio sudo[5828]: pam_unix(sudo:session): session closed for user root Nov 23 13:44:44 volumio volumio[643]: info: Shairport-Sync Started Nov 23 13:44:44 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 23 13:44:44 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Nov 23 13:44:44 volumio systemd[1]: shairport-sync.service: Succeeded. Nov 23 13:44:44 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 23 13:44:44 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 23 13:44:44 volumio sudo[5830]: pam_unix(sudo:session): session closed for user root Nov 23 13:44:44 volumio volumio[643]: info: Shairport-Sync Started Nov 23 13:44:44 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 23 13:44:44 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 23 13:44:44 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 23 13:44:44 volumio volumio[643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 23 13:44:45 volumio mpd[5820]: Nov 23 13:44 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 23 13:44:45 volumio systemd[1]: Started Music Player Daemon. Nov 23 13:44:45 volumio sudo[5808]: pam_unix(sudo:session): session closed for user root Nov 23 13:44:45 volumio sudo[5799]: pam_unix(sudo:session): session closed for user root Nov 23 13:44:45 volumio volumio[643]: error: MPD error: The expression evaluated to a falsy value: Nov 23 13:44:45 volumio volumio[643]: assert.ok(self.idling) Nov 23 13:44:45 volumio volumio[643]: error: The expression evaluated to a falsy value: Nov 23 13:44:45 volumio volumio[643]: assert.ok(self.idling) Nov 23 13:44:45 volumio volumio[643]: error: updateQueue error: null Nov 23 13:44:45 volumio volumio[643]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Total Clients: 6 Nov 23 13:44:45 volumio volumio[643]: info: CoreCommandRouter::volumioGetState Nov 23 13:44:45 volumio volumio[643]: info: CorePlayQueue::getTrack 304 Nov 23 13:44:47 volumio volumio[643]: error: Upnp client error: Error: This socket has been ended by the other party Nov 23 13:44:47 volumio volumio[643]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Nov 23 13:44:47 volumio volumio[643]: info: CoreStateMachine::getcurrentVolume Nov 23 13:44:47 volumio volumio[643]: info: CoreCommandRouter::volumioRetrievevolume Nov 23 13:44:47 volumio volumio[643]: info: VolumeController:: Volume=64 Mute =false Nov 23 13:44:47 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:44:47 volumio volumio[643]: info: CorePlayQueue::getTrack 304 Nov 23 13:44:47 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:44:47 volumio volumio[643]: info: CoreStateMachine::updateTrackBlock Nov 23 13:44:47 volumio volumio[643]: info: CorePlayQueue::getTrackBlock Nov 23 13:44:47 volumio volumio[643]: info: CoreCommandRouter::volumioRetrievevolume Nov 23 13:44:47 volumio volumio[643]: info: VolumeController:: Volume=64 Mute =false Nov 23 13:44:47 volumio volumio[643]: info: CoreStateMachine::pushState Nov 23 13:44:47 volumio volumio[643]: info: CorePlayQueue::getTrack 304 Nov 23 13:44:47 volumio volumio[643]: info: CoreCommandRouter::volumioPushState Nov 23 13:44:49 volumio volumio[643]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 23 13:44:49 volumio volumio[643]: Error: connect ETIMEDOUT 69.63.186.31:443 Nov 23 13:44:49 volumio volumio[643]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Nov 23 13:44:49 volumio volumio[643]: errno: -110, Nov 23 13:44:49 volumio volumio[643]: code: 'ETIMEDOUT', Nov 23 13:44:49 volumio volumio[643]: syscall: 'connect', Nov 23 13:44:49 volumio volumio[643]: address: '69.63.186.31', Nov 23 13:44:49 volumio volumio[643]: port: 443 Nov 23 13:44:49 volumio volumio[643]: } Nov 23 13:44:49 volumio volumio[643]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 23 13:44:49 volumio sudo[5919]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-23 13:43 Nov 23 13:44:49 volumio sudo[5919]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 23 13:44:49 volumio sudo[5775]: pam_unix(sudo:session): session closed for user root PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="e7445fab547cd22e23d9bef72406cfb610bc1d7d" VOLUMIO_FE_VERSION="5d5e99f8f803b3ec5fc5e8ca13bb4023600f3eee" VOLUMIO_FE3_VERSION="a6ae210575eae1ff43f06ab71e1cd17576840623" VOLUMIO_BE_VERSION="a9e1e1dd6072ffb15c0fcb8938d9ea0d8900c0da" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 24 Apr 2024 02:42:03 PM CEST" VOLUMIO_VERSION="3.661" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="c434411fe8754b648dc7feb1d8f43761"