Dec 06 18:49:00 volumio systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Dec 06 18:49:02 volumio systemd[1]: setdatetime-helper.service: Deactivated successfully. Dec 06 18:49:02 volumio systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Dec 06 18:49:26 volumio kernel: sd 0:0:0:0: [sda] tag#6 uas_eh_abort_handler 0 uas-tag 3 inflight: CMD IN Dec 06 18:49:26 volumio kernel: sd 0:0:0:0: [sda] tag#6 CDB: opcode=0x88 88 00 00 00 00 01 21 40 11 70 00 00 00 98 00 00 Dec 06 18:49:26 volumio kernel: sd 0:0:0:0: [sda] tag#5 uas_eh_abort_handler 0 uas-tag 2 inflight: CMD IN Dec 06 18:49:26 volumio kernel: sd 0:0:0:0: [sda] tag#5 CDB: opcode=0x88 88 00 00 00 00 01 21 40 11 68 00 00 00 08 00 00 Dec 06 18:49:26 volumio kernel: sd 0:0:0:0: [sda] tag#7 uas_eh_abort_handler 0 uas-tag 1 inflight: CMD IN Dec 06 18:49:26 volumio kernel: sd 0:0:0:0: [sda] tag#7 CDB: opcode=0x88 88 00 00 00 00 00 ef 67 74 30 00 00 01 e0 00 00 Dec 06 18:49:28 volumio kernel: sd 0:0:0:0: [sda] tag#4 uas_eh_abort_handler 0 uas-tag 4 inflight: CMD IN Dec 06 18:49:28 volumio kernel: sd 0:0:0:0: [sda] tag#4 CDB: opcode=0x88 88 00 00 00 00 00 ef 67 76 10 00 00 01 e0 00 00 Dec 06 18:49:31 volumio kernel: sd 0:0:0:0: [sda] tag#9 uas_eh_abort_handler 0 uas-tag 6 inflight: CMD OUT Dec 06 18:49:31 volumio kernel: sd 0:0:0:0: [sda] tag#9 CDB: opcode=0x8a 8a 00 00 00 00 01 5d 45 f9 58 00 00 00 80 00 00 Dec 06 18:49:31 volumio kernel: sd 0:0:0:0: [sda] tag#8 uas_eh_abort_handler 0 uas-tag 5 inflight: CMD OUT Dec 06 18:49:31 volumio kernel: sd 0:0:0:0: [sda] tag#8 CDB: opcode=0x8a 8a 00 00 00 00 01 5d 45 f5 58 00 00 04 00 00 00 Dec 06 18:49:31 volumio kernel: scsi host0: uas_eh_device_reset_handler start Dec 06 18:49:31 volumio kernel: usb 2-2: reset SuperSpeed USB device number 2 using xhci_hcd Dec 06 18:49:31 volumio kernel: scsi host0: uas_eh_device_reset_handler success Dec 06 18:49:31 volumio kernel: sd 0:0:0:0: [sda] tag#7 UNKNOWN(0x2003) Result: hostbyte=0x07 driverbyte=DRIVER_OK cmd_age=34s Dec 06 18:49:31 volumio kernel: sd 0:0:0:0: [sda] tag#7 CDB: opcode=0x88 88 00 00 00 00 00 ef 67 74 30 00 00 01 e0 00 00 Dec 06 18:49:31 volumio kernel: I/O error, dev sda, sector 4016534576 op 0x0:(READ) flags 0x80700 phys_seg 60 prio class 2 Dec 06 18:49:31 volumio kernel: sd 0:0:0:0: [sda] tag#4 UNKNOWN(0x2003) Result: hostbyte=0x07 driverbyte=DRIVER_OK cmd_age=32s Dec 06 18:49:31 volumio kernel: sd 0:0:0:0: [sda] tag#4 CDB: opcode=0x88 88 00 00 00 00 00 ef 67 76 10 00 00 01 e0 00 00 Dec 06 18:49:31 volumio kernel: I/O error, dev sda, sector 4016535056 op 0x0:(READ) flags 0x80700 phys_seg 60 prio class 2 Dec 06 18:49:42 volumio volumio[1259]: info: Dec 06 18:49:42 volumio volumio[1259]: ---------------------------- MPD announces system playlist update Dec 06 18:49:42 volumio volumio[1259]: info: Ignoring MPD Status Update Dec 06 18:49:42 volumio volumio[1259]: info: Dec 06 18:49:42 volumio volumio[1259]: ---------------------------- MPD announces state update: player Dec 06 18:49:42 volumio volumio[1259]: info: ControllerMpd::getState Dec 06 18:49:42 volumio volumio[1259]: verbose: ControllerMpd::sendMpdCommand status Dec 06 18:49:42 volumio volumio[1259]: info: ------------------------------ 2ms Dec 06 18:49:42 volumio volumio[1259]: info: sendMpdCommand status took 1 milliseconds Dec 06 18:49:42 volumio volumio[1259]: verbose: ControllerMpd::parseState Dec 06 18:49:42 volumio volumio[1259]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 18:49:42 volumio volumio[1259]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 06 18:49:42 volumio volumio[1259]: verbose: ControllerMpd::parseTrackInfo Dec 06 18:49:42 volumio volumio[1259]: info: ControllerMpd::pushState Dec 06 18:49:42 volumio volumio[1259]: info: CoreCommandRouter::servicePushState Dec 06 18:49:42 volumio volumio[1259]: info: CorePlayQueue::getTrack 1 Dec 06 18:49:42 volumio volumio[1259]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":196,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"The Vanishing Of Peter Strong","artist":"Yello","album":"Point","uri":"USB/269d89d1-7fef-4aa7-bd9a-4a765cdcbaf8/MUSIK/Yello/Yello - 2020 - Point [Hi-Res]/02 The Vanishing Of Peter Strong.flac","trackType":"flac"} Dec 06 18:49:42 volumio volumio[1259]: verbose: CURRENT POSITION 1 Dec 06 18:49:42 volumio volumio[1259]: info: CoreStateMachine::syncState stateService play Dec 06 18:49:42 volumio volumio[1259]: info: CoreStateMachine::syncState currentStatus play Dec 06 18:49:42 volumio volumio[1259]: info: Received an update from plugin. extracting info from payload Dec 06 18:49:42 volumio volumio[1259]: info: CoreStateMachine::pushState Dec 06 18:49:42 volumio volumio[1259]: info: CorePlayQueue::getTrack 1 Dec 06 18:49:42 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 06 18:49:42 volumio volumio[1259]: info: CoreCommandRouter::volumioPushState Dec 06 18:49:42 volumio volumio[1259]: info: CoreStateMachine::pushState Dec 06 18:49:42 volumio volumio[1259]: info: CorePlayQueue::getTrack 1 Dec 06 18:49:42 volumio volumio[1259]: info: CoreCommandRouter::volumioPushState Dec 06 18:49:42 volumio volumio[1259]: info: ------------------------------ 13ms Dec 06 18:50:03 volumio kernel: sd 0:0:0:0: [sda] tag#10 uas_eh_abort_handler 0 uas-tag 3 inflight: CMD IN Dec 06 18:50:03 volumio kernel: sd 0:0:0:0: [sda] tag#10 CDB: opcode=0x88 88 00 00 00 00 01 1e 40 1d 30 00 00 00 d8 00 00 Dec 06 18:50:03 volumio kernel: sd 0:0:0:0: [sda] tag#9 uas_eh_abort_handler 0 uas-tag 2 inflight: CMD IN Dec 06 18:50:03 volumio kernel: sd 0:0:0:0: [sda] tag#9 CDB: opcode=0x88 88 00 00 00 00 01 1e 40 1d 28 00 00 00 08 00 00 Dec 06 18:50:07 volumio kernel: sd 0:0:0:0: [sda] tag#28 uas_eh_abort_handler 0 uas-tag 25 inflight: CMD OUT Dec 06 18:50:07 volumio kernel: sd 0:0:0:0: [sda] tag#28 CDB: opcode=0x8a 8a 00 00 00 00 00 00 00 0f 68 00 00 00 10 00 00 Dec 06 18:50:07 volumio kernel: sd 0:0:0:0: [sda] tag#27 uas_eh_abort_handler 0 uas-tag 24 inflight: CMD OUT Dec 06 18:50:07 volumio kernel: sd 0:0:0:0: [sda] tag#27 CDB: opcode=0x8a 8a 00 00 00 00 00 00 00 0f 28 00 00 00 08 00 00 Dec 06 18:50:07 volumio kernel: sd 0:0:0:0: [sda] tag#26 uas_eh_abort_handler 0 uas-tag 23 inflight: CMD OUT Dec 06 18:50:07 volumio kernel: sd 0:0:0:0: [sda] tag#26 CDB: opcode=0x8a 8a 00 00 00 00 00 00 00 0f 00 00 00 00 08 00 00 Dec 06 18:50:07 volumio kernel: sd 0:0:0:0: [sda] tag#25 uas_eh_abort_handler 0 uas-tag 22 inflight: CMD OUT Dec 06 18:50:07 volumio kernel: sd 0:0:0:0: [sda] tag#25 CDB: opcode=0x8a 8a 00 00 00 00 00 00 00 0e b8 00 00 00 08 00 00 Dec 06 18:50:07 volumio kernel: sd 0:0:0:0: [sda] tag#24 uas_eh_abort_handler 0 uas-tag 21 inflight: CMD OUT Dec 06 18:50:07 volumio kernel: sd 0:0:0:0: [sda] tag#24 CDB: opcode=0x8a 8a 00 00 00 00 00 00 00 0e 88 00 00 00 08 00 00 Dec 06 18:50:07 volumio kernel: sd 0:0:0:0: [sda] tag#23 uas_eh_abort_handler 0 uas-tag 20 inflight: CMD OUT Dec 06 18:50:07 volumio kernel: sd 0:0:0:0: [sda] tag#23 CDB: opcode=0x8a 8a 00 00 00 00 00 00 00 0e 68 00 00 00 08 00 00 Dec 06 18:50:07 volumio kernel: sd 0:0:0:0: [sda] tag#22 uas_eh_abort_handler 0 uas-tag 19 inflight: CMD OUT Dec 06 18:50:07 volumio kernel: sd 0:0:0:0: [sda] tag#22 CDB: opcode=0x8a 8a 00 00 00 00 00 00 00 0d 98 00 00 00 08 00 00 Dec 06 18:50:07 volumio kernel: sd 0:0:0:0: [sda] tag#21 uas_eh_abort_handler 0 uas-tag 18 inflight: CMD OUT Dec 06 18:50:07 volumio kernel: sd 0:0:0:0: [sda] tag#21 CDB: opcode=0x8a 8a 00 00 00 00 00 00 00 0c c8 00 00 00 08 00 00 Dec 06 18:50:07 volumio kernel: sd 0:0:0:0: [sda] tag#20 uas_eh_abort_handler 0 uas-tag 17 inflight: CMD OUT Dec 06 18:50:07 volumio kernel: sd 0:0:0:0: [sda] tag#20 CDB: opcode=0x8a 8a 00 00 00 00 00 00 00 0c a8 00 00 00 18 00 00 Dec 06 18:50:07 volumio kernel: sd 0:0:0:0: [sda] tag#19 uas_eh_abort_handler 0 uas-tag 16 inflight: CMD OUT Dec 06 18:50:07 volumio kernel: sd 0:0:0:0: [sda] tag#19 CDB: opcode=0x8a 8a 00 00 00 00 00 00 00 0c 90 00 00 00 08 00 00 Dec 06 18:50:07 volumio kernel: sd 0:0:0:0: [sda] tag#18 uas_eh_abort_handler 0 uas-tag 15 inflight: CMD OUT Dec 06 18:50:07 volumio kernel: sd 0:0:0:0: [sda] tag#18 CDB: opcode=0x8a 8a 00 00 00 00 00 00 00 0c 78 00 00 00 08 00 00 Dec 06 18:50:07 volumio kernel: sd 0:0:0:0: [sda] tag#17 uas_eh_abort_handler 0 uas-tag 14 inflight: CMD OUT Dec 06 18:50:07 volumio kernel: sd 0:0:0:0: [sda] tag#17 CDB: opcode=0x8a 8a 00 00 00 00 00 00 00 0b f8 00 00 00 08 00 00 Dec 06 18:50:07 volumio kernel: sd 0:0:0:0: [sda] tag#16 uas_eh_abort_handler 0 uas-tag 13 inflight: CMD OUT Dec 06 18:50:07 volumio kernel: sd 0:0:0:0: [sda] tag#16 CDB: opcode=0x8a 8a 00 00 00 00 00 00 00 0b c0 00 00 00 08 00 00 Dec 06 18:50:07 volumio kernel: sd 0:0:0:0: [sda] tag#15 uas_eh_abort_handler 0 uas-tag 11 inflight: CMD OUT Dec 06 18:50:07 volumio kernel: sd 0:0:0:0: [sda] tag#15 CDB: opcode=0x8a 8a 00 00 00 00 00 00 00 0a 30 00 00 00 08 00 00 Dec 06 18:50:07 volumio kernel: sd 0:0:0:0: [sda] tag#14 uas_eh_abort_handler 0 uas-tag 10 inflight: CMD OUT Dec 06 18:50:07 volumio kernel: sd 0:0:0:0: [sda] tag#14 CDB: opcode=0x8a 8a 00 00 00 00 00 00 00 0a 18 00 00 00 08 00 00 Dec 06 18:50:07 volumio kernel: sd 0:0:0:0: [sda] tag#13 uas_eh_abort_handler 0 uas-tag 9 inflight: CMD OUT Dec 06 18:50:07 volumio kernel: sd 0:0:0:0: [sda] tag#13 CDB: opcode=0x8a 8a 00 00 00 00 00 00 00 09 60 00 00 00 08 00 00 Dec 06 18:50:07 volumio kernel: sd 0:0:0:0: [sda] tag#12 uas_eh_abort_handler 0 uas-tag 12 inflight: CMD OUT Dec 06 18:50:07 volumio kernel: sd 0:0:0:0: [sda] tag#12 CDB: opcode=0x8a 8a 00 00 00 00 00 00 00 0a b0 00 00 00 08 00 00 Dec 06 18:50:07 volumio kernel: sd 0:0:0:0: [sda] tag#11 uas_eh_abort_handler 0 uas-tag 7 inflight: CMD OUT Dec 06 18:50:07 volumio kernel: sd 0:0:0:0: [sda] tag#11 CDB: opcode=0x8a 8a 00 00 00 00 00 00 00 08 b0 00 00 00 08 00 00 Dec 06 18:50:07 volumio kernel: sd 0:0:0:0: [sda] tag#8 uas_eh_abort_handler 0 uas-tag 8 inflight: CMD OUT Dec 06 18:50:07 volumio kernel: sd 0:0:0:0: [sda] tag#8 CDB: opcode=0x8a 8a 00 00 00 00 00 00 00 08 d0 00 00 00 08 00 00 Dec 06 18:50:07 volumio kernel: sd 0:0:0:0: [sda] tag#7 uas_eh_abort_handler 0 uas-tag 6 inflight: CMD OUT Dec 06 18:50:07 volumio kernel: sd 0:0:0:0: [sda] tag#7 CDB: opcode=0x8a 8a 00 00 00 00 00 00 00 08 78 00 00 00 08 00 00 Dec 06 18:50:07 volumio kernel: sd 0:0:0:0: [sda] tag#6 uas_eh_abort_handler 0 uas-tag 5 inflight: CMD OUT Dec 06 18:50:07 volumio kernel: sd 0:0:0:0: [sda] tag#6 CDB: opcode=0x8a 8a 00 00 00 00 00 00 00 08 48 00 00 00 10 00 00 Dec 06 18:50:07 volumio kernel: sd 0:0:0:0: [sda] tag#5 uas_eh_abort_handler 0 uas-tag 4 inflight: CMD OUT Dec 06 18:50:07 volumio kernel: sd 0:0:0:0: [sda] tag#5 CDB: opcode=0x8a 8a 00 00 00 00 00 00 00 08 28 00 00 00 08 00 00 Dec 06 18:50:07 volumio kernel: sd 0:0:0:0: [sda] tag#4 uas_eh_abort_handler 0 uas-tag 1 inflight: CMD OUT Dec 06 18:50:07 volumio kernel: sd 0:0:0:0: [sda] tag#4 CDB: opcode=0x8a 8a 00 00 00 00 00 00 00 08 10 00 00 00 08 00 00 Dec 06 18:50:07 volumio kernel: sd 0:0:0:0: [sda] tag#3 uas_eh_abort_handler 0 uas-tag 29 inflight: CMD OUT Dec 06 18:50:07 volumio kernel: sd 0:0:0:0: [sda] tag#3 CDB: opcode=0x8a 8a 00 00 00 00 00 00 00 3d f0 00 00 00 08 00 00 Dec 06 18:50:07 volumio kernel: sd 0:0:0:0: [sda] tag#2 uas_eh_abort_handler 0 uas-tag 28 inflight: CMD OUT Dec 06 18:50:07 volumio kernel: sd 0:0:0:0: [sda] tag#2 CDB: opcode=0x8a 8a 00 00 00 00 00 00 00 11 00 00 00 00 08 00 00 Dec 06 18:50:07 volumio kernel: sd 0:0:0:0: [sda] tag#1 uas_eh_abort_handler 0 uas-tag 26 inflight: CMD OUT Dec 06 18:50:07 volumio kernel: sd 0:0:0:0: [sda] tag#1 CDB: opcode=0x8a 8a 00 00 00 00 00 00 00 0f e0 00 00 00 08 00 00 Dec 06 18:50:07 volumio kernel: sd 0:0:0:0: [sda] tag#0 uas_eh_abort_handler 0 uas-tag 27 inflight: CMD OUT Dec 06 18:50:07 volumio kernel: sd 0:0:0:0: [sda] tag#0 CDB: opcode=0x8a 8a 00 00 00 00 00 00 00 10 e8 00 00 00 08 00 00 Dec 06 18:50:07 volumio kernel: scsi host0: uas_eh_device_reset_handler start Dec 06 18:50:07 volumio kernel: usb 2-2: reset SuperSpeed USB device number 2 using xhci_hcd Dec 06 18:50:07 volumio kernel: scsi host0: uas_eh_device_reset_handler success Dec 06 18:50:07 volumio volumio[1259]: info: Dec 06 18:50:07 volumio volumio[1259]: ---------------------------- MPD announces state update: player Dec 06 18:50:07 volumio volumio[1259]: info: ControllerMpd::getState Dec 06 18:50:07 volumio volumio[1259]: verbose: ControllerMpd::sendMpdCommand status Dec 06 18:50:07 volumio volumio[1259]: info: Dec 06 18:50:07 volumio volumio[1259]: ---------------------------- MPD announces state update: player Dec 06 18:50:07 volumio volumio[1259]: info: ControllerMpd::getState Dec 06 18:50:07 volumio volumio[1259]: verbose: ControllerMpd::sendMpdCommand status Dec 06 18:50:07 volumio volumio[1259]: info: sendMpdCommand status took 2 milliseconds Dec 06 18:50:07 volumio volumio[1259]: verbose: ControllerMpd::parseState Dec 06 18:50:07 volumio volumio[1259]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 18:50:07 volumio volumio[1259]: info: sendMpdCommand status took 3 milliseconds Dec 06 18:50:07 volumio volumio[1259]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 06 18:50:07 volumio volumio[1259]: verbose: ControllerMpd::parseState Dec 06 18:50:07 volumio volumio[1259]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 18:50:07 volumio volumio[1259]: verbose: ControllerMpd::parseTrackInfo Dec 06 18:50:07 volumio volumio[1259]: info: ControllerMpd::pushState Dec 06 18:50:07 volumio volumio[1259]: info: CoreCommandRouter::servicePushState Dec 06 18:50:07 volumio volumio[1259]: info: CorePlayQueue::getTrack 1 Dec 06 18:50:07 volumio volumio[1259]: verbose: STATE SERVICE {"status":"play","position":0,"seek":284,"duration":196,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"1101 Kbps","isStreaming":false,"title":"The Vanishing Of Peter Strong","artist":"Yello","album":"Point","uri":"USB/269d89d1-7fef-4aa7-bd9a-4a765cdcbaf8/MUSIK/Yello/Yello - 2020 - Point [Hi-Res]/02 The Vanishing Of Peter Strong.flac","trackType":"flac"} Dec 06 18:50:07 volumio volumio[1259]: verbose: CURRENT POSITION 1 Dec 06 18:50:07 volumio volumio[1259]: info: CoreStateMachine::syncState stateService play Dec 06 18:50:07 volumio volumio[1259]: info: CoreStateMachine::syncState currentStatus play Dec 06 18:50:07 volumio volumio[1259]: info: Received an update from plugin. extracting info from payload Dec 06 18:50:07 volumio volumio[1259]: info: CoreStateMachine::pushState Dec 06 18:50:07 volumio volumio[1259]: info: CorePlayQueue::getTrack 1 Dec 06 18:50:07 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 06 18:50:07 volumio volumio[1259]: info: CoreCommandRouter::volumioPushState Dec 06 18:50:07 volumio volumio[1259]: info: CoreStateMachine::pushState Dec 06 18:50:07 volumio volumio[1259]: info: CorePlayQueue::getTrack 1 Dec 06 18:50:07 volumio volumio[1259]: info: CoreCommandRouter::volumioPushState Dec 06 18:50:07 volumio volumio[1259]: info: ------------------------------ 19ms Dec 06 18:50:07 volumio volumio[1259]: info: sendMpdCommand playlistinfo took 13 milliseconds Dec 06 18:50:07 volumio volumio[1259]: verbose: ControllerMpd::parseTrackInfo Dec 06 18:50:07 volumio volumio[1259]: info: ControllerMpd::pushState Dec 06 18:50:07 volumio volumio[1259]: info: CoreCommandRouter::servicePushState Dec 06 18:50:07 volumio volumio[1259]: info: CorePlayQueue::getTrack 1 Dec 06 18:50:07 volumio volumio[1259]: verbose: STATE SERVICE {"status":"play","position":0,"seek":452,"duration":196,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"1056 Kbps","isStreaming":false,"title":"The Vanishing Of Peter Strong","artist":"Yello","album":"Point","uri":"USB/269d89d1-7fef-4aa7-bd9a-4a765cdcbaf8/MUSIK/Yello/Yello - 2020 - Point [Hi-Res]/02 The Vanishing Of Peter Strong.flac","trackType":"flac"} Dec 06 18:50:07 volumio volumio[1259]: verbose: CURRENT POSITION 1 Dec 06 18:50:07 volumio volumio[1259]: info: CoreStateMachine::syncState stateService play Dec 06 18:50:07 volumio volumio[1259]: info: CoreStateMachine::syncState currentStatus play Dec 06 18:50:07 volumio volumio[1259]: info: Received an update from plugin. extracting info from payload Dec 06 18:50:07 volumio volumio[1259]: info: CoreStateMachine::pushState Dec 06 18:50:07 volumio volumio[1259]: info: CorePlayQueue::getTrack 1 Dec 06 18:50:07 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 06 18:50:07 volumio volumio[1259]: info: CoreCommandRouter::volumioPushState Dec 06 18:50:07 volumio volumio[1259]: info: CoreStateMachine::pushState Dec 06 18:50:07 volumio volumio[1259]: info: CorePlayQueue::getTrack 1 Dec 06 18:50:07 volumio volumio[1259]: info: CoreCommandRouter::volumioPushState Dec 06 18:50:07 volumio volumio[1259]: info: ------------------------------ 30ms Dec 06 18:50:22 volumio volumio[1259]: info: Preload queue cleared Dec 06 18:50:22 volumio volumio[1259]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 06 18:50:22 volumio volumio[1259]: info: CoreStateMachine::ClearQueue Dec 06 18:50:22 volumio volumio[1259]: info: CoreStateMachine::stop Dec 06 18:50:22 volumio volumio[1259]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 06 18:50:22 volumio volumio[1259]: info: CoreStateMachine::stPlaybackTimer Dec 06 18:50:22 volumio volumio[1259]: info: CoreStateMachine::updateTrackBlock Dec 06 18:50:22 volumio volumio[1259]: info: CorePlayQueue::getTrackBlock Dec 06 18:50:22 volumio volumio[1259]: info: CoreStateMachine::pushState Dec 06 18:50:22 volumio volumio[1259]: info: CorePlayQueue::getTrack 1 Dec 06 18:50:22 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 06 18:50:22 volumio volumio[1259]: info: CoreCommandRouter::volumioPushState Dec 06 18:50:22 volumio volumio[1259]: info: CoreStateMachine::serviceStop Dec 06 18:50:22 volumio volumio[1259]: info: CorePlayQueue::getTrack 1 Dec 06 18:50:22 volumio volumio[1259]: info: CoreCommandRouter::serviceStop Dec 06 18:50:22 volumio volumio[1259]: info: ControllerMpd::stop Dec 06 18:50:22 volumio volumio[1259]: verbose: ControllerMpd::sendMpdCommand stop Dec 06 18:50:22 volumio volumio[1259]: info: CorePlayQueue::clearPlayQueue Dec 06 18:50:22 volumio volumio[1259]: info: CorePlayQueue::saveQueue Dec 06 18:50:22 volumio volumio[1259]: info: CoreCommandRouter::volumioPushQueue Dec 06 18:50:22 volumio volumio[1259]: info: CoreStateMachine::addQueueItems Dec 06 18:50:22 volumio volumio[1259]: info: CorePlayQueue::addQueueItems Dec 06 18:50:22 volumio volumio[1259]: info: Preload queue cleared Dec 06 18:50:22 volumio volumio[1259]: info: Adding Item to queue: music-library/USB/269d89d1-7fef-4aa7-bd9a-4a765cdcbaf8/MUSIK/Yello/Yello - Stella (24.192) Dec 06 18:50:22 volumio volumio[1259]: info: Exploding uri music-library/USB/269d89d1-7fef-4aa7-bd9a-4a765cdcbaf8/MUSIK/Yello/Yello - Stella (24.192) in service mpd Dec 06 18:50:23 volumio volumio[1259]: info: ALBUMART /albumart?cacheid=605&web=Yello/Stella/extralarge&path=%2Fmnt%2FUSB%2F269d89d1-7fef-4aa7-bd9a-4a765cdcbaf8%2FMUSIK%2FYello%2FYello%20-%20Stella%20(24.192)%2FYello%20-%20Stella%20(24.192).cue&metadata=false Dec 06 18:50:23 volumio volumio[1259]: info: URI /mnt/USB/269d89d1-7fef-4aa7-bd9a-4a765cdcbaf8/MUSIK/Yello/Yello - Stella (24.192)/Yello - Stella (24.192).cue Dec 06 18:50:23 volumio volumio[1259]: info: ALBUMART /albumart?cacheid=605&web=Yello/Stella/extralarge&path=%2Fmnt%2FUSB%2F269d89d1-7fef-4aa7-bd9a-4a765cdcbaf8%2FMUSIK%2FYello%2FYello%20-%20Stella%20(24.192)%2FYello%20-%20Stella%20(24.192).cue&metadata=false Dec 06 18:50:23 volumio volumio[1259]: info: URI /mnt/USB/269d89d1-7fef-4aa7-bd9a-4a765cdcbaf8/MUSIK/Yello/Yello - Stella (24.192)/Yello - Stella (24.192).cue Dec 06 18:50:23 volumio volumio[1259]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 06 18:50:23 volumio volumio[1259]: Error: Unable to resolve or reject the same promise twice Dec 06 18:50:23 volumio volumio[1259]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Dec 06 18:50:23 volumio volumio[1259]: at /volumio/app/plugins/music_service/mpd/index.js:2587:21 Dec 06 18:50:23 volumio volumio[1259]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Dec 06 18:50:23 volumio volumio[1259]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Dec 06 18:50:23 volumio volumio[1259]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Dec 06 18:50:23 volumio volumio[1259]: at Socket.emit (node:events:514:28) Dec 06 18:50:23 volumio volumio[1259]: at addChunk (node:internal/streams/readable:343:12) Dec 06 18:50:23 volumio volumio[1259]: at readableAddChunk (node:internal/streams/readable:312:11) Dec 06 18:50:23 volumio volumio[1259]: at Readable.push (node:internal/streams/readable:253:10) Dec 06 18:50:23 volumio volumio[1259]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23) Dec 06 18:50:23 volumio volumio[1259]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 06 18:50:23 volumio sudo[4946]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-06 18:49' Dec 06 18:50:23 volumio sudo[4946]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"