-- Logs begin at Thu 2025-10-23 06:58:52 UTC, end at Tue 2025-12-23 05:54:25 UTC. -- Dec 23 05:53:00 opera kernel: scsi 30:0:0:0: Direct-Access TOSHIBA EXTERNAL_USB 0 PQ: 0 ANSI: 6 Dec 23 05:53:00 opera kernel: sd 30:0:0:0: [sda] Spinning up disk... Dec 23 05:53:00 opera kernel: usb 1-1.2: USB disconnect, device number 42 Dec 23 05:53:00 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:00 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:00 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:00 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:00 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:00 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:00 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:00 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:00 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:00 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:00 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:00 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:00 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:00 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:00 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:00 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:00 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:00 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:00 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:00 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:00 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:00 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:00 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:00 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:00 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:00 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:00 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:00 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:00 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:00 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:00 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:01 opera kernel: .ready Dec 23 05:53:01 opera kernel: sd 30:0:0:0: [sda] Read Capacity(10) failed: Result: hostbyte=0x01 driverbyte=0x00 Dec 23 05:53:01 opera kernel: sd 30:0:0:0: [sda] Sense not available. Dec 23 05:53:01 opera kernel: sd 30:0:0:0: [sda] Write Protect is on Dec 23 05:53:01 opera kernel: sd 30:0:0:0: [sda] Mode Sense: 20 04 d1 ef Dec 23 05:53:01 opera kernel: sd 30:0:0:0: [sda] No Caching mode page found Dec 23 05:53:01 opera kernel: sd 30:0:0:0: [sda] Assuming drive cache: write through Dec 23 05:53:01 opera kernel: sd 30:0:0:0: [sda] Read Capacity(10) failed: Result: hostbyte=0x01 driverbyte=0x00 Dec 23 05:53:01 opera kernel: sd 30:0:0:0: [sda] Sense not available. Dec 23 05:53:01 opera kernel: sd 30:0:0:0: [sda] Write Protect is off Dec 23 05:53:01 opera kernel: sd 30:0:0:0: [sda] Mode Sense: 00 00 00 00 Dec 23 05:53:01 opera kernel: sd 30:0:0:0: [sda] Attached SCSI disk Dec 23 05:53:01 opera systemd-udevd[1715]: inotify_add_watch(6, /dev/sda, 10) failed: No such file or directory Dec 23 05:53:01 opera systemd-udevd[1715]: inotify_add_watch(6, /dev/sda, 10) failed: No such file or directory Dec 23 05:53:01 opera kernel: usb 1-1.2: new high-speed USB device number 43 using dwc2 Dec 23 05:53:01 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:01 opera kernel: usb 1-1.2: New USB device found, idVendor=0480, idProduct=0826 Dec 23 05:53:01 opera kernel: usb 1-1.2: New USB device strings: Mfr=2, Product=3, SerialNumber=1 Dec 23 05:53:01 opera kernel: usb 1-1.2: Product: EXTERNAL_USB Dec 23 05:53:01 opera kernel: usb 1-1.2: Manufacturer: TOSHIBA Dec 23 05:53:01 opera kernel: usb 1-1.2: SerialNumber: 20220116005052F Dec 23 05:53:01 opera kernel: usb-storage 1-1.2:1.0: USB Mass Storage device detected Dec 23 05:53:01 opera kernel: scsi host31: usb-storage 1-1.2:1.0 Dec 23 05:53:02 opera kernel: usb 1-1.2: USB disconnect, device number 43 Dec 23 05:53:02 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:03 opera kernel: usb 1-1.2: new high-speed USB device number 44 using dwc2 Dec 23 05:53:03 opera kernel: usb 1-1.2: New USB device found, idVendor=0480, idProduct=0826 Dec 23 05:53:03 opera kernel: usb 1-1.2: New USB device strings: Mfr=2, Product=3, SerialNumber=1 Dec 23 05:53:03 opera kernel: usb 1-1.2: Product: EXTERNAL_USB Dec 23 05:53:03 opera kernel: usb 1-1.2: Manufacturer: TOSHIBA Dec 23 05:53:03 opera kernel: usb 1-1.2: SerialNumber: 20220116005052F Dec 23 05:53:03 opera kernel: usb-storage 1-1.2:1.0: USB Mass Storage device detected Dec 23 05:53:03 opera kernel: scsi host32: usb-storage 1-1.2:1.0 Dec 23 05:53:03 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:04 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:04 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:04 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:04 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:04 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:04 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:04 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:04 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:04 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:04 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:04 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:04 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:04 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:04 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:04 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:04 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:04 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:04 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:04 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:04 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:04 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:04 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:04 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:04 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:04 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:04 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:04 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:04 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:04 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:04 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:04 opera kernel: scsi 32:0:0:0: Direct-Access TOSHIBA EXTERNAL_USB 0 PQ: 0 ANSI: 6 Dec 23 05:53:04 opera kernel: sd 32:0:0:0: [sda] Spinning up disk... Dec 23 05:53:04 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:05 opera kernel: .ready Dec 23 05:53:05 opera kernel: sd 32:0:0:0: [sda] 1953525168 512-byte logical blocks: (1.00 TB/932 GiB) Dec 23 05:53:05 opera kernel: sd 32:0:0:0: [sda] Write Protect is off Dec 23 05:53:05 opera kernel: sd 32:0:0:0: [sda] Mode Sense: 43 00 00 00 Dec 23 05:53:05 opera kernel: sd 32:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA Dec 23 05:53:05 opera kernel: sda: sda1 Dec 23 05:53:05 opera kernel: sd 32:0:0:0: [sda] Attached SCSI disk Dec 23 05:53:05 opera udisks-glue[680]: Device file /dev/sda inserted Dec 23 05:53:05 opera udisks-glue[680]: Device file /dev/sda1 inserted Dec 23 05:53:05 opera udisks-glue[680]: Trying to automount /dev/sda1... Dec 23 05:53:05 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:06 opera ntfs-3g[2233]: Version 2014.2.15AR.2 integrated FUSE 28 Dec 23 05:53:06 opera ntfs-3g[2233]: Mounted /dev/sda1 (Read-Write, label "yy1", NTFS 3.1) Dec 23 05:53:06 opera ntfs-3g[2233]: Cmdline options: rw,nodev,nosuid,noatime,uid=1000,gid=1000,dmask=0077,fmask=0177,dmask=0000,fmask=0000,uhelper=udisks Dec 23 05:53:06 opera ntfs-3g[2233]: Mount options: rw,nodev,nosuid,uhelper=udisks,allow_other,nonempty,noatime,default_permissions,fsname=/dev/sda1,blkdev,blksize=4096 Dec 23 05:53:06 opera ntfs-3g[2233]: Global ownership and permissions enforced, configuration type 7 Dec 23 05:53:06 opera udisks-glue[680]: Successfully automounted /dev/sda1 at /media/yy1_ Dec 23 05:53:06 opera udisks-glue[680]: Device file /dev/sda1 mounted at /media/yy1_ Dec 23 05:53:06 opera udisks-glue[680]: Updating DB (#24) ... Dec 23 05:53:06 opera udisks-glue[680]: volume: n/a repeat: off random: off single: off consume: off Dec 23 05:53:06 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Dec 23 05:53:06 opera volumio[1181]: info: Dec 23 05:53:06 opera volumio[1181]: ---------------------------- MPD announces state update: update Dec 23 05:53:06 opera volumio[1181]: info: ControllerMpd::getState Dec 23 05:53:06 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Dec 23 05:53:06 opera volumio[1181]: info: sendMpdCommand status took 3 milliseconds Dec 23 05:53:06 opera volumio[1181]: info: sendMpdCommand status took 3 milliseconds Dec 23 05:53:06 opera volumio[1181]: verbose: ControllerMpd::parseState Dec 23 05:53:06 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:06 opera volumio[1181]: info: Command Router : Notfying DB Updatetrue Dec 23 05:53:06 opera volumio[1181]: info: CoreCommandRouter::Close All Modals sent Dec 23 05:53:06 opera volumio[1181]: verbose: ControllerMpd::parseState Dec 23 05:53:06 opera volumio[1181]: info: ControllerMpd::pushState Dec 23 05:53:06 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:06 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:06 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:06 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:06 opera volumio[1181]: info: CorePlayQueue::getTrack 1316 Dec 23 05:53:06 opera volumio[1181]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 23 05:53:06 opera volumio[1181]: verbose: CURRENT POSITION 1316 Dec 23 05:53:06 opera volumio[1181]: info: CoreStateMachine::syncState stateService stop Dec 23 05:53:07 opera volumio[1181]: info: CoreStateMachine::syncState currentStatus play Dec 23 05:53:07 opera volumio[1181]: info: CoreStateMachine::play index undefined Dec 23 05:53:07 opera volumio[1181]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 23 05:53:07 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:07 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:07 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:07 opera volumio[1181]: info: CorePlayQueue::getTrack 52 Dec 23 05:53:07 opera volumio[1181]: info: CoreStateMachine::startPlaybackTimer Dec 23 05:53:07 opera volumio[1181]: info: CorePlayQueue::getTrack 52 Dec 23 05:53:07 opera volumio[1181]: verbose: ControllerMpd::clearAddPlayTracks USB/yy1_/DSD/AV Show 2006/08 - Gerard Schwarz Y Chamber Sym. of New York - Joseph Haydn-Trumpet Concerto in E-flat major finale, alleg.dff Dec 23 05:53:07 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand stop Dec 23 05:53:07 opera volumio[1181]: info: ------------------------------ 46ms Dec 23 05:53:07 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:07 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:07 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:07 opera volumio[1181]: info: sendMpdCommand stop took 9 milliseconds Dec 23 05:53:07 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand clear Dec 23 05:53:07 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:07 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:07 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:07 opera volumio[1181]: info: Dec 23 05:53:07 opera volumio[1181]: ---------------------------- MPD announces system playlist update Dec 23 05:53:07 opera volumio[1181]: info: Ignoring MPD Status Update Dec 23 05:53:07 opera volumio[1181]: info: sendMpdCommand clear took 11 milliseconds Dec 23 05:53:07 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand add "USB/yy1_/DSD/AV Show 2006/08 - Gerard Schwarz Y Chamber Sym. of New York - Joseph Haydn-Trumpet Concerto in E-flat major finale, alleg.dff" Dec 23 05:53:07 opera volumio[1181]: error: updateQueue error: null Dec 23 05:53:07 opera volumio[1181]: info: ------------------------------ 2ms Dec 23 05:53:07 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:07 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:07 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:07 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:07 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:07 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:07 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:07 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:07 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:07 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:07 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:07 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:07 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:07 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:07 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:07 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:07 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:07 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:07 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:07 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:07 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:07 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:07 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:07 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:07 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:07 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:07 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:07 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:07 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:07 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:07 opera udisks-glue[680]: Device file /dev/sda1 unmounted from /media/yy1_ Dec 23 05:53:07 opera kernel: usb 1-1.2: USB disconnect, device number 44 Dec 23 05:53:07 opera kernel: sd 32:0:0:0: [sda] Synchronizing SCSI cache Dec 23 05:53:07 opera kernel: sd 32:0:0:0: [sda] tag#0 UNKNOWN(0x2003) Result: hostbyte=0x01 driverbyte=0x00 Dec 23 05:53:07 opera kernel: sd 32:0:0:0: [sda] tag#0 CDB: opcode=0x28 28 00 00 26 52 c0 00 00 f0 00 Dec 23 05:53:07 opera kernel: blk_update_request: I/O error, dev sda, sector 2511552 Dec 23 05:53:07 opera kernel: sd 32:0:0:0: [sda] tag#0 UNKNOWN(0x2003) Result: hostbyte=0x01 driverbyte=0x00 Dec 23 05:53:07 opera kernel: sd 32:0:0:0: [sda] tag#0 CDB: opcode=0x28 28 00 00 26 53 b0 00 00 10 00 Dec 23 05:53:07 opera kernel: blk_update_request: I/O error, dev sda, sector 2511792 Dec 23 05:53:07 opera ntfs-3g[2233]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Dec 23 05:53:07 opera ntfs-3g[2233]: ntfs_attr_pread error reading '/DSD/2015原音精選 DSD 64/14.春江花月夜.dsf' at offset 237133824: 131072 <> -1: Input/output error Dec 23 05:53:07 opera ntfs-3g[2233]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Dec 23 05:53:07 opera ntfs-3g[2233]: ntfs_attr_pread error reading '/DSD/2015原音精選 DSD 64/14.春江花月夜.dsf' at offset 237264896: 131072 <> -1: Input/output error Dec 23 05:53:07 opera ntfs-3g[2233]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Dec 23 05:53:07 opera ntfs-3g[2233]: ntfs_attr_pread error reading '/DSD/2015原音精選 DSD 64/14.春江花月夜.dsf' at offset 237395968: 131072 <> -1: Input/output error Dec 23 05:53:07 opera ntfs-3g[2233]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Dec 23 05:53:07 opera ntfs-3g[2233]: ntfs_attr_pread error reading '/DSD/2015原音精選 DSD 64/14.春江花月夜.dsf' at offset 237527040: 76782 <> -1: Input/output error Dec 23 05:53:07 opera ntfs-3g[2233]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Dec 23 05:53:07 opera ntfs-3g[2233]: ntfs_attr_pread error reading '/DSD/2015原音精選 DSD 64/14.春江花月夜.dsf' at offset 237133824: 4096 <> -1: Input/output error Dec 23 05:53:07 opera kernel: sd 32:0:0:0: [sda] Synchronize Cache(10) failed: Result: hostbyte=0x01 driverbyte=0x00 Dec 23 05:53:07 opera udisks-glue[680]: Device file /dev/sda1 removed Dec 23 05:53:07 opera udisks-glue[680]: Updating DB (#24) ... Dec 23 05:53:07 opera udisks-glue[680]: volume: n/a repeat: off random: off single: off consume: off Dec 23 05:53:07 opera udisks-glue[680]: Device file /dev/sda removed Dec 23 05:53:07 opera volumio[1181]: info: MPD Database updated - AlbumList cache refreshed Dec 23 05:53:07 opera volumio[1181]: info: Dec 23 05:53:07 opera volumio[1181]: ---------------------------- MPD announces state update: database Dec 23 05:53:07 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Dec 23 05:53:07 opera volumio[1181]: info: Dec 23 05:53:07 opera volumio[1181]: ---------------------------- MPD announces state update: update Dec 23 05:53:07 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:07 opera volumio[1181]: info: ControllerMpd::getState Dec 23 05:53:07 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Dec 23 05:53:07 opera volumio[1181]: info: ControllerMpd::getState Dec 23 05:53:07 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Dec 23 05:53:07 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Dec 23 05:53:07 opera volumio[1181]: info: Dec 23 05:53:07 opera volumio[1181]: ---------------------------- MPD announces state update: update Dec 23 05:53:07 opera volumio[1181]: info: ControllerMpd::getState Dec 23 05:53:07 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Dec 23 05:53:07 opera volumio[1181]: info: sendMpdCommand status took 13 milliseconds Dec 23 05:53:07 opera volumio[1181]: info: sendMpdCommand status took 13 milliseconds Dec 23 05:53:07 opera volumio[1181]: info: sendMpdCommand status took 12 milliseconds Dec 23 05:53:08 opera volumio[1181]: verbose: ControllerMpd::parseState Dec 23 05:53:07 opera ntfs-3g[2233]: Unmounting /dev/sda1 (yy1) Dec 23 05:53:07 opera ntfs-3g[2233]: Failed to sync device /dev/sda1: Input/output error Dec 23 05:53:07 opera ntfs-3g[2233]: Failed to close volume /dev/sda1: Input/output error Dec 23 05:53:08 opera udisks-glue[680]: Updating DB (#24) ... Dec 23 05:53:08 opera udisks-glue[680]: volume: n/a repeat: off random: off single: off consume: off Dec 23 05:53:08 opera volumio[1181]: info: Command Router : Notfying DB Updatefalse Dec 23 05:53:08 opera volumio[1181]: info: CoreCommandRouter::Close All Modals sent Dec 23 05:53:08 opera volumio[1181]: verbose: ControllerMpd::parseState Dec 23 05:53:08 opera volumio[1181]: verbose: ControllerMpd::parseState Dec 23 05:53:08 opera volumio[1181]: info: ControllerMpd::pushState Dec 23 05:53:08 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:08 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:08 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:08 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:08 opera volumio[1181]: info: CorePlayQueue::getTrack 52 Dec 23 05:53:08 opera volumio[1181]: 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} Dec 23 05:53:08 opera volumio[1181]: verbose: CURRENT POSITION 52 Dec 23 05:53:08 opera volumio[1181]: info: CoreStateMachine::syncState stateService stop Dec 23 05:53:08 opera volumio[1181]: info: CoreStateMachine::syncState currentStatus play Dec 23 05:53:08 opera volumio[1181]: info: CoreStateMachine::play index undefined Dec 23 05:53:08 opera volumio[1181]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 23 05:53:08 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:08 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:08 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:08 opera volumio[1181]: info: ControllerMpd::pushState Dec 23 05:53:08 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:08 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:08 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:08 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:08 opera volumio[1181]: info: CorePlayQueue::getTrack 130 Dec 23 05:53:08 opera volumio[1181]: 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} Dec 23 05:53:08 opera volumio[1181]: verbose: CURRENT POSITION 130 Dec 23 05:53:08 opera volumio[1181]: info: CoreStateMachine::syncState stateService stop Dec 23 05:53:08 opera volumio[1181]: info: CoreStateMachine::syncState currentStatus stop Dec 23 05:53:08 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:08 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:08 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:08 opera volumio[1181]: info: No code Dec 23 05:53:08 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:08 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:08 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:08 opera volumio[1181]: info: CorePlayQueue::getTrack 130 Dec 23 05:53:08 opera volumio[1181]: info: CoreStateMachine::startPlaybackTimer Dec 23 05:53:08 opera volumio[1181]: info: CorePlayQueue::getTrack 130 Dec 23 05:53:08 opera volumio[1181]: verbose: ControllerMpd::clearAddPlayTracks USB/yy1_/DSD/AV Show 2012/13 - The Fishing Song.dsf Dec 23 05:53:08 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand stop Dec 23 05:53:08 opera volumio[1181]: info: ------------------------------ 90ms Dec 23 05:53:08 opera volumio[1181]: info: ------------------------------ 91ms Dec 23 05:53:08 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:08 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:08 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:08 opera volumio[1181]: info: sendMpdCommand status took 97 milliseconds Dec 23 05:53:08 opera volumio[1181]: info: sendMpdCommand status took 88 milliseconds Dec 23 05:53:08 opera volumio[1181]: info: sendMpdCommand stop took 12 milliseconds Dec 23 05:53:08 opera volumio[1181]: verbose: ControllerMpd::parseState Dec 23 05:53:08 opera volumio[1181]: info: Command Router : Notfying DB Updatefalse Dec 23 05:53:08 opera volumio[1181]: info: CoreCommandRouter::Close All Modals sent Dec 23 05:53:08 opera volumio[1181]: verbose: ControllerMpd::parseState Dec 23 05:53:08 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand clear Dec 23 05:53:08 opera volumio[1181]: info: ControllerMpd::pushState Dec 23 05:53:08 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:08 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:08 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:08 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:08 opera volumio[1181]: info: CorePlayQueue::getTrack 130 Dec 23 05:53:08 opera volumio[1181]: 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} Dec 23 05:53:08 opera volumio[1181]: verbose: CURRENT POSITION 130 Dec 23 05:53:08 opera volumio[1181]: info: CoreStateMachine::syncState stateService stop Dec 23 05:53:08 opera volumio[1181]: info: CoreStateMachine::syncState currentStatus stop Dec 23 05:53:08 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:08 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:08 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:08 opera volumio[1181]: info: No code Dec 23 05:53:08 opera kernel: usb 1-1.2: new high-speed USB device number 45 using dwc2 Dec 23 05:53:08 opera kernel: usb 1-1.2: New USB device found, idVendor=0480, idProduct=0826 Dec 23 05:53:08 opera kernel: usb 1-1.2: New USB device strings: Mfr=2, Product=3, SerialNumber=1 Dec 23 05:53:08 opera kernel: usb 1-1.2: Product: EXTERNAL_USB Dec 23 05:53:08 opera kernel: usb 1-1.2: Manufacturer: TOSHIBA Dec 23 05:53:08 opera kernel: usb 1-1.2: SerialNumber: 20220116005052F Dec 23 05:53:08 opera kernel: usb-storage 1-1.2:1.0: USB Mass Storage device detected Dec 23 05:53:08 opera kernel: scsi host33: usb-storage 1-1.2:1.0 Dec 23 05:53:08 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:09 opera kernel: scsi 33:0:0:0: Direct-Access TOSHIBA EXTERNAL_USB 0 PQ: 0 ANSI: 6 Dec 23 05:53:09 opera kernel: sd 33:0:0:0: [sda] Spinning up disk... Dec 23 05:53:09 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:10 opera kernel: .ready Dec 23 05:53:10 opera kernel: sd 33:0:0:0: [sda] 1953525168 512-byte logical blocks: (1.00 TB/932 GiB) Dec 23 05:53:10 opera kernel: sd 33:0:0:0: [sda] Write Protect is off Dec 23 05:53:10 opera kernel: sd 33:0:0:0: [sda] Mode Sense: 43 00 00 00 Dec 23 05:53:10 opera kernel: sd 33:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA Dec 23 05:53:10 opera kernel: sda: sda1 Dec 23 05:53:10 opera kernel: sd 33:0:0:0: [sda] Attached SCSI disk Dec 23 05:53:10 opera udisks-glue[680]: Device file /dev/sda inserted Dec 23 05:53:10 opera udisks-glue[680]: Device file /dev/sda1 inserted Dec 23 05:53:10 opera udisks-glue[680]: Trying to automount /dev/sda1... Dec 23 05:53:10 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:11 opera systemd-journal[252]: Suppressed 20 messages from /system.slice/volumio.service Dec 23 05:53:11 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:11 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:11 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:11 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:11 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:11 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:11 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:11 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:11 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:11 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:11 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:11 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:11 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:11 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:11 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:11 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:11 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:11 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:11 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:11 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:11 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:11 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:11 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:11 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:11 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:11 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:11 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:11 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:11 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:11 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:11 opera kernel: usb 1-1.2: USB disconnect, device number 45 Dec 23 05:53:11 opera kernel: sd 33:0:0:0: [sda] Synchronizing SCSI cache Dec 23 05:53:11 opera kernel: sd 33:0:0:0: [sda] tag#0 UNKNOWN(0x2003) Result: hostbyte=0x01 driverbyte=0x00 Dec 23 05:53:11 opera kernel: sd 33:0:0:0: [sda] tag#0 CDB: opcode=0x28 28 00 00 5c 1f 08 00 00 08 00 Dec 23 05:53:11 opera kernel: blk_update_request: I/O error, dev sda, sector 6037256 Dec 23 05:53:11 opera kernel: blk_update_request: I/O error, dev sda, sector 0 Dec 23 05:53:11 opera kernel: sd 33:0:0:0: [sda] Synchronize Cache(10) failed: Result: hostbyte=0x01 driverbyte=0x00 Dec 23 05:53:11 opera udisks-glue[680]: Failed to automount /dev/sda1: Error mounting: mount exited with exit code 13: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Dec 23 05:53:11 opera udisks-glue[680]: Failed to read first NTFS_BLOCK_SIZE bytes of potential restart page. Dec 23 05:53:11 opera udisks-glue[680]: The file system wasn't safely closed on Windows. Fixing. Dec 23 05:53:11 opera udisks-glue[680]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Dec 23 05:53:11 opera udisks-glue[680]: Failed to read of MFT, mft=2 count=1 br=-1: Input/output error Dec 23 05:53:11 opera udisks-glue[680]: Failed to open inode FILE_LogFile: Input/output error Dec 23 05:53:11 opera udisks-glue[680]: Failed to sync device /dev/sda1: Input/output error Dec 23 05:53:11 opera udisks-glue[680]: Failed to mount '/dev/sda1': Input/output error Dec 23 05:53:11 opera udisks-glue[680]: NTFS is either inconsistent, or there is a hardware fault, or it's a Dec 23 05:53:11 opera udisks-glue[680]: SoftRAID/FakeRAID hardware. In the first case run chkdsk /f on Windows Dec 23 05:53:11 opera udisks-glue[680]: then reboot into Windows twice. The usage of the /f parameter is very Dec 23 05:53:11 opera udisks-glue[680]: important! If the device is a SoftRAID/FakeRAID then first activate Dec 23 05:53:11 opera udisks-glue[680]: it and mount a different device under the /dev/mapper/ directory, (e.g. Dec 23 05:53:11 opera udisks-glue[680]: /dev/mapper/nvidia_eahaabcc1). Please see the 'dmraid' documentation Dec 23 05:53:11 opera udisks-glue[680]: for more details. Dec 23 05:53:11 opera udisks-glue[680]: Device file /dev/sda1 removed Dec 23 05:53:11 opera udisks-glue[680]: Device file /dev/sda removed Dec 23 05:53:11 opera udisks-glue[680]: Updating DB (#27) ... Dec 23 05:53:11 opera udisks-glue[680]: volume: n/a repeat: off random: off single: off consume: off Dec 23 05:53:11 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Dec 23 05:53:11 opera volumio[1181]: info: Dec 23 05:53:11 opera volumio[1181]: ---------------------------- MPD announces state update: update Dec 23 05:53:11 opera volumio[1181]: info: ControllerMpd::getState Dec 23 05:53:11 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Dec 23 05:53:11 opera volumio[1181]: info: sendMpdCommand status took 1 milliseconds Dec 23 05:53:11 opera volumio[1181]: info: sendMpdCommand status took 2 milliseconds Dec 23 05:53:11 opera volumio[1181]: verbose: ControllerMpd::parseState Dec 23 05:53:11 opera volumio[1181]: info: Command Router : Notfying DB Updatetrue Dec 23 05:53:11 opera volumio[1181]: info: CoreCommandRouter::Close All Modals sent Dec 23 05:53:11 opera volumio[1181]: verbose: ControllerMpd::parseState Dec 23 05:53:11 opera volumio[1181]: info: ControllerMpd::pushState Dec 23 05:53:11 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:11 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:11 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:11 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:11 opera volumio[1181]: info: CorePlayQueue::getTrack 130 Dec 23 05:53:11 opera volumio[1181]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 23 05:53:11 opera volumio[1181]: verbose: CURRENT POSITION 130 Dec 23 05:53:11 opera volumio[1181]: info: CoreStateMachine::syncState stateService stop Dec 23 05:53:11 opera volumio[1181]: info: CoreStateMachine::syncState currentStatus play Dec 23 05:53:11 opera volumio[1181]: info: CoreStateMachine::play index undefined Dec 23 05:53:11 opera volumio[1181]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 23 05:53:11 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:11 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:11 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:11 opera volumio[1181]: info: CorePlayQueue::getTrack 888 Dec 23 05:53:11 opera volumio[1181]: info: CoreStateMachine::startPlaybackTimer Dec 23 05:53:11 opera volumio[1181]: info: CorePlayQueue::getTrack 888 Dec 23 05:53:11 opera volumio[1181]: verbose: ControllerMpd::clearAddPlayTracks USB/yy1_/DSD/村治佳織 Transformations SACD/21 - Kaori Muraji Dominic Miller - Fragile.dff Dec 23 05:53:11 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand stop Dec 23 05:53:11 opera volumio[1181]: info: ------------------------------ 40ms Dec 23 05:53:11 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:11 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:11 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:11 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Dec 23 05:53:11 opera volumio[1181]: info: Dec 23 05:53:11 opera volumio[1181]: ---------------------------- MPD announces state update: update Dec 23 05:53:11 opera volumio[1181]: info: ControllerMpd::getState Dec 23 05:53:11 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Dec 23 05:53:11 opera volumio[1181]: info: sendMpdCommand stop took 8 milliseconds Dec 23 05:53:11 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand clear Dec 23 05:53:11 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:11 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:11 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:11 opera volumio[1181]: info: Dec 23 05:53:11 opera volumio[1181]: ---------------------------- MPD announces system playlist update Dec 23 05:53:11 opera volumio[1181]: info: Ignoring MPD Status Update Dec 23 05:53:11 opera volumio[1181]: info: sendMpdCommand status took 13 milliseconds Dec 23 05:53:11 opera volumio[1181]: info: sendMpdCommand status took 13 milliseconds Dec 23 05:53:11 opera volumio[1181]: info: sendMpdCommand clear took 12 milliseconds Dec 23 05:53:11 opera volumio[1181]: verbose: ControllerMpd::parseState Dec 23 05:53:11 opera volumio[1181]: info: Command Router : Notfying DB Updatefalse Dec 23 05:53:11 opera volumio[1181]: info: CoreCommandRouter::Close All Modals sent Dec 23 05:53:11 opera volumio[1181]: verbose: ControllerMpd::parseState Dec 23 05:53:11 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand add "USB/yy1_/DSD/村治佳織 Transformations SACD/21 - Kaori Muraji Dominic Miller - Fragile.dff" Dec 23 05:53:11 opera volumio[1181]: info: ControllerMpd::pushState Dec 23 05:53:11 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:11 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:11 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:11 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:11 opera volumio[1181]: info: CorePlayQueue::getTrack 888 Dec 23 05:53:11 opera volumio[1181]: 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} Dec 23 05:53:11 opera volumio[1181]: verbose: CURRENT POSITION 888 Dec 23 05:53:11 opera volumio[1181]: info: CoreStateMachine::syncState stateService stop Dec 23 05:53:11 opera volumio[1181]: info: CoreStateMachine::syncState currentStatus stop Dec 23 05:53:11 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:11 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:11 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:11 opera volumio[1181]: info: No code Dec 23 05:53:11 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:11 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:11 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:11 opera volumio[1181]: info: ------------------------------ 45ms Dec 23 05:53:11 opera volumio[1181]: error: updateQueue error: null Dec 23 05:53:11 opera volumio[1181]: info: ------------------------------ 33ms Dec 23 05:53:11 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:11 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:11 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:11 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:12 opera kernel: usb 1-1.2: new high-speed USB device number 46 using dwc2 Dec 23 05:53:12 opera kernel: usb 1-1.2: New USB device found, idVendor=0480, idProduct=0826 Dec 23 05:53:12 opera kernel: usb 1-1.2: New USB device strings: Mfr=2, Product=3, SerialNumber=1 Dec 23 05:53:12 opera kernel: usb 1-1.2: Product: EXTERNAL_USB Dec 23 05:53:12 opera kernel: usb 1-1.2: Manufacturer: TOSHIBA Dec 23 05:53:12 opera kernel: usb 1-1.2: SerialNumber: 20220116005052F Dec 23 05:53:12 opera kernel: usb-storage 1-1.2:1.0: USB Mass Storage device detected Dec 23 05:53:12 opera kernel: scsi host34: usb-storage 1-1.2:1.0 Dec 23 05:53:12 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:13 opera kernel: usb 1-1.2: USB disconnect, device number 46 Dec 23 05:53:13 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:14 opera kernel: usb 1-1.2: new high-speed USB device number 47 using dwc2 Dec 23 05:53:14 opera kernel: usb 1-1.2: New USB device found, idVendor=0480, idProduct=0826 Dec 23 05:53:14 opera kernel: usb 1-1.2: New USB device strings: Mfr=2, Product=3, SerialNumber=1 Dec 23 05:53:14 opera kernel: usb 1-1.2: Product: EXTERNAL_USB Dec 23 05:53:14 opera kernel: usb 1-1.2: Manufacturer: TOSHIBA Dec 23 05:53:14 opera kernel: usb 1-1.2: SerialNumber: 20220116005052F Dec 23 05:53:14 opera kernel: usb-storage 1-1.2:1.0: USB Mass Storage device detected Dec 23 05:53:14 opera kernel: scsi host35: usb-storage 1-1.2:1.0 Dec 23 05:53:14 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:15 opera kernel: scsi 35:0:0:0: Direct-Access TOSHIBA EXTERNAL_USB 0 PQ: 0 ANSI: 6 Dec 23 05:53:15 opera kernel: sd 35:0:0:0: [sda] Spinning up disk... Dec 23 05:53:15 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:15 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:15 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:15 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:15 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:15 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:15 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:15 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:15 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:15 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:15 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:15 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:15 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:15 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:15 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:15 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:15 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:15 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:15 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:15 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:15 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:15 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:15 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:15 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:15 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:15 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:15 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:15 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:15 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:15 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:15 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:16 opera kernel: .ready Dec 23 05:53:16 opera kernel: sd 35:0:0:0: [sda] 1953525168 512-byte logical blocks: (1.00 TB/932 GiB) Dec 23 05:53:16 opera kernel: sd 35:0:0:0: [sda] Write Protect is off Dec 23 05:53:16 opera kernel: sd 35:0:0:0: [sda] Mode Sense: 43 00 00 00 Dec 23 05:53:16 opera kernel: sd 35:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA Dec 23 05:53:16 opera kernel: sda: sda1 Dec 23 05:53:16 opera kernel: sd 35:0:0:0: [sda] Attached SCSI disk Dec 23 05:53:16 opera udisks-glue[680]: Device file /dev/sda inserted Dec 23 05:53:16 opera udisks-glue[680]: Device file /dev/sda1 inserted Dec 23 05:53:16 opera udisks-glue[680]: Trying to automount /dev/sda1... Dec 23 05:53:16 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Dec 23 05:53:16 opera volumio[1181]: info: Dec 23 05:53:16 opera volumio[1181]: ---------------------------- MPD announces state update: update Dec 23 05:53:16 opera volumio[1181]: info: ControllerMpd::getState Dec 23 05:53:16 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Dec 23 05:53:16 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Dec 23 05:53:16 opera volumio[1181]: info: Dec 23 05:53:16 opera volumio[1181]: ---------------------------- MPD announces state update: update Dec 23 05:53:16 opera volumio[1181]: info: ControllerMpd::getState Dec 23 05:53:16 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Dec 23 05:53:16 opera volumio[1181]: info: sendMpdCommand status took 2 milliseconds Dec 23 05:53:16 opera volumio[1181]: verbose: ControllerMpd::parseState Dec 23 05:53:16 opera volumio[1181]: info: Command Router : Notfying DB Updatefalse Dec 23 05:53:16 opera volumio[1181]: info: CoreCommandRouter::Close All Modals sent Dec 23 05:53:16 opera volumio[1181]: info: sendMpdCommand status took 27 milliseconds Dec 23 05:53:16 opera volumio[1181]: info: sendMpdCommand status took 27 milliseconds Dec 23 05:53:16 opera volumio[1181]: info: sendMpdCommand status took 27 milliseconds Dec 23 05:53:16 opera volumio[1181]: verbose: ControllerMpd::parseState Dec 23 05:53:16 opera volumio[1181]: verbose: ControllerMpd::parseState Dec 23 05:53:16 opera volumio[1181]: info: Command Router : Notfying DB Updatefalse Dec 23 05:53:16 opera volumio[1181]: info: CoreCommandRouter::Close All Modals sent Dec 23 05:53:16 opera volumio[1181]: verbose: ControllerMpd::parseState Dec 23 05:53:16 opera volumio[1181]: info: ControllerMpd::pushState Dec 23 05:53:16 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:16 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:16 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:16 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:16 opera volumio[1181]: info: CorePlayQueue::getTrack 888 Dec 23 05:53:16 opera volumio[1181]: 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} Dec 23 05:53:16 opera volumio[1181]: verbose: CURRENT POSITION 888 Dec 23 05:53:16 opera volumio[1181]: info: CoreStateMachine::syncState stateService stop Dec 23 05:53:16 opera volumio[1181]: info: CoreStateMachine::syncState currentStatus play Dec 23 05:53:16 opera volumio[1181]: info: CoreStateMachine::play index undefined Dec 23 05:53:16 opera volumio[1181]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 23 05:53:16 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:16 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:16 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:16 opera volumio[1181]: info: ControllerMpd::pushState Dec 23 05:53:16 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:16 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:16 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:16 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:16 opera volumio[1181]: info: CorePlayQueue::getTrack 1244 Dec 23 05:53:16 opera volumio[1181]: 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} Dec 23 05:53:16 opera volumio[1181]: verbose: CURRENT POSITION 1244 Dec 23 05:53:16 opera volumio[1181]: info: CoreStateMachine::syncState stateService stop Dec 23 05:53:16 opera volumio[1181]: info: CoreStateMachine::syncState currentStatus stop Dec 23 05:53:16 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:16 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:16 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:16 opera volumio[1181]: info: No code Dec 23 05:53:16 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:16 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:16 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:16 opera volumio[1181]: info: CorePlayQueue::getTrack 1244 Dec 23 05:53:16 opera volumio[1181]: info: CoreStateMachine::startPlaybackTimer Dec 23 05:53:16 opera volumio[1181]: info: CorePlayQueue::getTrack 1244 Dec 23 05:53:16 opera volumio[1181]: verbose: ControllerMpd::clearAddPlayTracks USB/yy1_/DSD/綾戸智絵 To You SACD/14 - My Way.dff Dec 23 05:53:16 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand stop Dec 23 05:53:16 opera volumio[1181]: info: ------------------------------ 75ms Dec 23 05:53:16 opera volumio[1181]: info: ------------------------------ 83ms Dec 23 05:53:16 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:16 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:16 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:16 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:16 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:16 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:16 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:16 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:16 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:16 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:16 opera volumio[1181]: info: sendMpdCommand stop took 34 milliseconds Dec 23 05:53:16 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand clear Dec 23 05:53:16 opera volumio[1181]: info: Dec 23 05:53:16 opera volumio[1181]: ---------------------------- MPD announces system playlist update Dec 23 05:53:16 opera volumio[1181]: info: Ignoring MPD Status Update Dec 23 05:53:16 opera volumio[1181]: info: sendMpdCommand clear took 1 milliseconds Dec 23 05:53:16 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand add "USB/yy1_/DSD/綾戸智絵 To You SACD/14 - My Way.dff" Dec 23 05:53:16 opera volumio[1181]: error: updateQueue error: null Dec 23 05:53:16 opera volumio[1181]: info: ------------------------------ 1ms Dec 23 05:53:17 opera ntfs-3g[2307]: Version 2014.2.15AR.2 integrated FUSE 28 Dec 23 05:53:17 opera ntfs-3g[2307]: Mounted /dev/sda1 (Read-Write, label "yy1", NTFS 3.1) Dec 23 05:53:17 opera ntfs-3g[2307]: Cmdline options: rw,nodev,nosuid,noatime,uid=1000,gid=1000,dmask=0077,fmask=0177,dmask=0000,fmask=0000,uhelper=udisks Dec 23 05:53:17 opera ntfs-3g[2307]: Mount options: rw,nodev,nosuid,uhelper=udisks,allow_other,nonempty,noatime,default_permissions,fsname=/dev/sda1,blkdev,blksize=4096 Dec 23 05:53:17 opera ntfs-3g[2307]: Global ownership and permissions enforced, configuration type 7 Dec 23 05:53:17 opera udisks-glue[680]: Successfully automounted /dev/sda1 at /media/yy1_ Dec 23 05:53:17 opera udisks-glue[680]: Device file /dev/sda1 mounted at /media/yy1_ Dec 23 05:53:17 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Dec 23 05:53:17 opera volumio[1181]: info: Dec 23 05:53:17 opera volumio[1181]: ---------------------------- MPD announces state update: update Dec 23 05:53:17 opera volumio[1181]: info: ControllerMpd::getState Dec 23 05:53:17 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Dec 23 05:53:17 opera volumio[1181]: info: sendMpdCommand status took 1 milliseconds Dec 23 05:53:17 opera volumio[1181]: info: sendMpdCommand status took 1 milliseconds Dec 23 05:53:17 opera volumio[1181]: verbose: ControllerMpd::parseState Dec 23 05:53:17 opera udisks-glue[680]: Updating DB (#29) ... Dec 23 05:53:17 opera udisks-glue[680]: volume: n/a repeat: off random: off single: off consume: off Dec 23 05:53:17 opera volumio[1181]: info: Command Router : Notfying DB Updatetrue Dec 23 05:53:17 opera volumio[1181]: info: CoreCommandRouter::Close All Modals sent Dec 23 05:53:17 opera volumio[1181]: verbose: ControllerMpd::parseState Dec 23 05:53:17 opera volumio[1181]: info: ControllerMpd::pushState Dec 23 05:53:17 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:17 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:17 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:17 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:17 opera volumio[1181]: info: CorePlayQueue::getTrack 1244 Dec 23 05:53:17 opera volumio[1181]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 23 05:53:17 opera volumio[1181]: verbose: CURRENT POSITION 1244 Dec 23 05:53:17 opera volumio[1181]: info: CoreStateMachine::syncState stateService stop Dec 23 05:53:17 opera volumio[1181]: info: CoreStateMachine::syncState currentStatus stop Dec 23 05:53:17 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:17 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:17 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:17 opera volumio[1181]: info: No code Dec 23 05:53:17 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:17 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:17 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:17 opera volumio[1181]: info: ------------------------------ 35ms Dec 23 05:53:17 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:17 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:17 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:17 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:18 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:18 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:18 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:18 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:18 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:18 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:18 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:18 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:18 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:18 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:18 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:18 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:18 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:18 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:18 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:18 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:18 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:18 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:18 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:18 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:18 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:18 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:18 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:18 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:18 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:18 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:18 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:18 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:18 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:18 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:18 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:19 opera kernel: usb 1-1.2: USB disconnect, device number 47 Dec 23 05:53:19 opera udisks-glue[680]: Device file /dev/sda1 unmounted from /media/yy1_ Dec 23 05:53:19 opera udisks-glue[680]: Device file /dev/sda1 removed Dec 23 05:53:19 opera ntfs-3g[2307]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Dec 23 05:53:19 opera ntfs-3g[2307]: ntfs_attr_pread error reading '/DSD/2016 原音精選 DSD/1. 08 周華健 - 讓我歡喜讓我憂.dsf' at offset 194109440: 131072 <> -1: Input/output error Dec 23 05:53:19 opera ntfs-3g[2307]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Dec 23 05:53:19 opera ntfs-3g[2307]: ntfs_attr_pread error reading '/DSD/2016 原音精選 DSD/1. 08 周華健 - 讓我歡喜讓我憂.dsf' at offset 194240512: 131072 <> -1: Input/output error Dec 23 05:53:19 opera ntfs-3g[2307]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Dec 23 05:53:19 opera ntfs-3g[2307]: ntfs_attr_pread error reading '/DSD/2016 原音精選 DSD/1. 08 周華健 - 讓我歡喜讓我憂.dsf' at offset 194371584: 113832 <> -1: Input/output error Dec 23 05:53:19 opera kernel: sd 35:0:0:0: [sda] Synchronizing SCSI cache Dec 23 05:53:19 opera kernel: sd 35:0:0:0: [sda] tag#0 UNKNOWN(0x2003) Result: hostbyte=0x01 driverbyte=0x00 Dec 23 05:53:19 opera kernel: sd 35:0:0:0: [sda] tag#0 CDB: opcode=0x28 28 00 00 87 3f f0 00 00 f0 00 Dec 23 05:53:19 opera kernel: blk_update_request: I/O error, dev sda, sector 8863728 Dec 23 05:53:19 opera kernel: sd 35:0:0:0: [sda] tag#0 UNKNOWN(0x2003) Result: hostbyte=0x01 driverbyte=0x00 Dec 23 05:53:19 opera kernel: sd 35:0:0:0: [sda] tag#0 CDB: opcode=0x28 28 00 00 87 40 e0 00 00 10 00 Dec 23 05:53:19 opera kernel: blk_update_request: I/O error, dev sda, sector 8863968 Dec 23 05:53:19 opera kernel: sd 35:0:0:0: [sda] Synchronize Cache(10) failed: Result: hostbyte=0x01 driverbyte=0x00 Dec 23 05:53:19 opera ntfs-3g[2307]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Dec 23 05:53:19 opera ntfs-3g[2307]: ntfs_attr_pread error reading '/DSD/2016 原音精選 DSD/1. 08 周華健 - 讓我歡喜讓我憂.dsf' at offset 194109440: 4096 <> -1: Input/output error Dec 23 05:53:19 opera udisks-glue[680]: Updating DB (#29) ... Dec 23 05:53:19 opera udisks-glue[680]: volume: n/a repeat: off random: off single: off consume: off Dec 23 05:53:19 opera udisks-glue[680]: Device file /dev/sda removed Dec 23 05:53:19 opera ntfs-3g[2307]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Dec 23 05:53:19 opera ntfs-3g[2307]: ntfs_attr_pread error reading '/DSD/2016 原音精選 DSD/1. 08 周華健 - 讓我歡喜讓我憂.dsf' at offset 194482176: 3240 <> -1: Input/output error Dec 23 05:53:19 opera ntfs-3g[2307]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Dec 23 05:53:19 opera ntfs-3g[2307]: ntfs_attr_pread error reading '/DSD/2016 原音精選 DSD/1. 08 周華健 - 讓我歡喜讓我憂.dsf' at offset 194482176: 3240 <> -1: Input/output error Dec 23 05:53:19 opera ntfs-3g[2307]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Dec 23 05:53:19 opera ntfs-3g[2307]: ntfs_attr_pread error reading '/DSD/2016 原音精選 DSD/1. 08 周華健 - 讓我歡喜讓我憂.dsf' at offset 194482176: 3240 <> -1: Input/output error Dec 23 05:53:19 opera kernel: Buffer I/O error on dev sda1, logical block 1107801, async page read Dec 23 05:53:19 opera kernel: Buffer I/O error on dev sda1, logical block 1107801, async page read Dec 23 05:53:19 opera kernel: Buffer I/O error on dev sda1, logical block 1107801, async page read Dec 23 05:53:19 opera udisks-glue[680]: Updating DB (#29) ... Dec 23 05:53:19 opera udisks-glue[680]: volume: n/a repeat: off random: off single: off consume: off Dec 23 05:53:19 opera volumio[1181]: info: MPD Database updated - AlbumList cache refreshed Dec 23 05:53:19 opera volumio[1181]: info: Dec 23 05:53:19 opera volumio[1181]: ---------------------------- MPD announces state update: database Dec 23 05:53:19 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Dec 23 05:53:19 opera volumio[1181]: info: Dec 23 05:53:19 opera volumio[1181]: ---------------------------- MPD announces state update: update Dec 23 05:53:19 opera volumio[1181]: info: ControllerMpd::getState Dec 23 05:53:19 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Dec 23 05:53:19 opera volumio[1181]: info: ControllerMpd::getState Dec 23 05:53:19 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Dec 23 05:53:19 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Dec 23 05:53:19 opera volumio[1181]: info: Dec 23 05:53:19 opera volumio[1181]: ---------------------------- MPD announces state update: update Dec 23 05:53:19 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Dec 23 05:53:19 opera volumio[1181]: info: Dec 23 05:53:19 opera volumio[1181]: ---------------------------- MPD announces state update: update Dec 23 05:53:19 opera volumio[1181]: info: ControllerMpd::getState Dec 23 05:53:19 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Dec 23 05:53:19 opera volumio[1181]: info: sendMpdCommand status took 7 milliseconds Dec 23 05:53:19 opera volumio[1181]: info: ControllerMpd::getState Dec 23 05:53:19 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Dec 23 05:53:19 opera volumio[1181]: info: sendMpdCommand status took 7 milliseconds Dec 23 05:53:19 opera volumio[1181]: info: sendMpdCommand status took 7 milliseconds Dec 23 05:53:19 opera volumio[1181]: verbose: ControllerMpd::parseState Dec 23 05:53:19 opera volumio[1181]: info: Command Router : Notfying DB Updatetrue Dec 23 05:53:19 opera volumio[1181]: info: CoreCommandRouter::Close All Modals sent Dec 23 05:53:19 opera ntfs-3g[2307]: Unmounting /dev/sda1 (yy1) Dec 23 05:53:19 opera ntfs-3g[2307]: Failed to sync device /dev/sda1: Input/output error Dec 23 05:53:19 opera ntfs-3g[2307]: Failed to close volume /dev/sda1: Input/output error Dec 23 05:53:19 opera volumio[1181]: verbose: ControllerMpd::parseState Dec 23 05:53:19 opera volumio[1181]: verbose: ControllerMpd::parseState Dec 23 05:53:19 opera volumio[1181]: info: ControllerMpd::pushState Dec 23 05:53:19 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:19 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:19 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:19 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:19 opera volumio[1181]: info: CorePlayQueue::getTrack 1244 Dec 23 05:53:19 opera volumio[1181]: 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} Dec 23 05:53:19 opera volumio[1181]: verbose: CURRENT POSITION 1244 Dec 23 05:53:19 opera volumio[1181]: info: CoreStateMachine::syncState stateService stop Dec 23 05:53:19 opera volumio[1181]: info: CoreStateMachine::syncState currentStatus play Dec 23 05:53:19 opera volumio[1181]: info: CoreStateMachine::play index undefined Dec 23 05:53:19 opera volumio[1181]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 23 05:53:19 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:19 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:19 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:19 opera volumio[1181]: info: ControllerMpd::pushState Dec 23 05:53:19 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:19 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:19 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:19 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:19 opera volumio[1181]: info: CorePlayQueue::getTrack 1715 Dec 23 05:53:19 opera volumio[1181]: 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} Dec 23 05:53:19 opera volumio[1181]: verbose: CURRENT POSITION 1715 Dec 23 05:53:19 opera volumio[1181]: info: CoreStateMachine::syncState stateService stop Dec 23 05:53:19 opera volumio[1181]: info: CoreStateMachine::syncState currentStatus stop Dec 23 05:53:19 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:19 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:19 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:19 opera volumio[1181]: info: No code Dec 23 05:53:19 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:19 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:19 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:19 opera volumio[1181]: info: CorePlayQueue::getTrack 1715 Dec 23 05:53:19 opera volumio[1181]: info: CoreStateMachine::startPlaybackTimer Dec 23 05:53:19 opera volumio[1181]: info: CorePlayQueue::getTrack 1715 Dec 23 05:53:19 opera volumio[1181]: verbose: ControllerMpd::clearAddPlayTracks USB/yy1_/DSD/靚聲王SACD/01 -偶遇 - 林志美.dff Dec 23 05:53:19 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand stop Dec 23 05:53:19 opera volumio[1181]: info: ------------------------------ 85ms Dec 23 05:53:19 opera volumio[1181]: info: ------------------------------ 85ms Dec 23 05:53:19 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:19 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:19 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:19 opera volumio[1181]: info: sendMpdCommand status took 96 milliseconds Dec 23 05:53:19 opera volumio[1181]: info: sendMpdCommand status took 96 milliseconds Dec 23 05:53:19 opera volumio[1181]: info: sendMpdCommand status took 95 milliseconds Dec 23 05:53:19 opera volumio[1181]: info: sendMpdCommand status took 95 milliseconds Dec 23 05:53:19 opera volumio[1181]: info: sendMpdCommand stop took 20 milliseconds Dec 23 05:53:19 opera volumio[1181]: verbose: ControllerMpd::parseState Dec 23 05:53:19 opera volumio[1181]: info: Command Router : Notfying DB Updatefalse Dec 23 05:53:19 opera volumio[1181]: info: CoreCommandRouter::Close All Modals sent Dec 23 05:53:19 opera volumio[1181]: verbose: ControllerMpd::parseState Dec 23 05:53:19 opera volumio[1181]: info: Command Router : Notfying DB Updatefalse Dec 23 05:53:19 opera volumio[1181]: info: CoreCommandRouter::Close All Modals sent Dec 23 05:53:19 opera volumio[1181]: verbose: ControllerMpd::parseState Dec 23 05:53:19 opera volumio[1181]: verbose: ControllerMpd::parseState Dec 23 05:53:19 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand clear Dec 23 05:53:19 opera volumio[1181]: info: ControllerMpd::pushState Dec 23 05:53:19 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:19 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:19 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:19 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:19 opera volumio[1181]: info: CorePlayQueue::getTrack 1715 Dec 23 05:53:19 opera volumio[1181]: 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} Dec 23 05:53:19 opera volumio[1181]: verbose: CURRENT POSITION 1715 Dec 23 05:53:19 opera volumio[1181]: info: CoreStateMachine::syncState stateService stop Dec 23 05:53:19 opera volumio[1181]: info: CoreStateMachine::syncState currentStatus stop Dec 23 05:53:19 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:19 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:19 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:19 opera volumio[1181]: info: No code Dec 23 05:53:19 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:19 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:19 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:19 opera volumio[1181]: info: ControllerMpd::pushState Dec 23 05:53:19 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:19 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:19 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:19 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:19 opera volumio[1181]: info: CorePlayQueue::getTrack 1715 Dec 23 05:53:19 opera volumio[1181]: 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} Dec 23 05:53:19 opera volumio[1181]: verbose: CURRENT POSITION 1715 Dec 23 05:53:19 opera volumio[1181]: info: CoreStateMachine::syncState stateService stop Dec 23 05:53:19 opera volumio[1181]: info: CoreStateMachine::syncState currentStatus stop Dec 23 05:53:19 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:19 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:19 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:19 opera volumio[1181]: info: No code Dec 23 05:53:19 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:19 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:19 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:19 opera volumio[1181]: info: ------------------------------ 189ms Dec 23 05:53:19 opera volumio[1181]: info: ------------------------------ 192ms Dec 23 05:53:19 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:19 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:19 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:19 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:19 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:19 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:19 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:19 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:19 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:19 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:19 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:19 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:19 opera volumio[1181]: info: Dec 23 05:53:19 opera volumio[1181]: ---------------------------- MPD announces system playlist update Dec 23 05:53:19 opera volumio[1181]: info: Ignoring MPD Status Update Dec 23 05:53:19 opera volumio[1181]: info: sendMpdCommand clear took 90 milliseconds Dec 23 05:53:19 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand add "USB/yy1_/DSD/靚聲王SACD/01 -偶遇 - 林志美.dff" Dec 23 05:53:19 opera volumio[1181]: error: updateQueue error: null Dec 23 05:53:19 opera volumio[1181]: info: ------------------------------ 3ms Dec 23 05:53:19 opera kernel: usb 1-1.2: new high-speed USB device number 48 using dwc2 Dec 23 05:53:19 opera kernel: usb 1-1.2: New USB device found, idVendor=0480, idProduct=0826 Dec 23 05:53:19 opera kernel: usb 1-1.2: New USB device strings: Mfr=2, Product=3, SerialNumber=1 Dec 23 05:53:19 opera kernel: usb 1-1.2: Product: EXTERNAL_USB Dec 23 05:53:19 opera kernel: usb 1-1.2: Manufacturer: TOSHIBA Dec 23 05:53:19 opera kernel: usb 1-1.2: SerialNumber: 20220116005052F Dec 23 05:53:19 opera kernel: usb-storage 1-1.2:1.0: USB Mass Storage device detected Dec 23 05:53:19 opera kernel: scsi host36: usb-storage 1-1.2:1.0 Dec 23 05:53:19 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:20 opera kernel: scsi 36:0:0:0: Direct-Access TOSHIBA EXTERNAL_USB 0 PQ: 0 ANSI: 6 Dec 23 05:53:20 opera kernel: sd 36:0:0:0: [sda] Spinning up disk... Dec 23 05:53:20 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:21 opera kernel: .ready Dec 23 05:53:21 opera kernel: sd 36:0:0:0: [sda] 1953525168 512-byte logical blocks: (1.00 TB/932 GiB) Dec 23 05:53:21 opera kernel: sd 36:0:0:0: [sda] Write Protect is off Dec 23 05:53:21 opera kernel: sd 36:0:0:0: [sda] Mode Sense: 43 00 00 00 Dec 23 05:53:21 opera kernel: sd 36:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA Dec 23 05:53:21 opera kernel: sda: sda1 Dec 23 05:53:21 opera kernel: sd 36:0:0:0: [sda] Attached SCSI disk Dec 23 05:53:21 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:22 opera udisks-glue[680]: Device file /dev/sda inserted Dec 23 05:53:22 opera udisks-glue[680]: Device file /dev/sda1 inserted Dec 23 05:53:22 opera udisks-glue[680]: Trying to automount /dev/sda1... Dec 23 05:53:22 opera systemd[1]: Started volumio-remote-updater-push.service. Dec 23 05:53:22 opera systemd[1]: Starting Multi-User System. Dec 23 05:53:22 opera systemd[1]: Reached target Multi-User System. Dec 23 05:53:22 opera systemd[1]: Starting Graphical Interface. Dec 23 05:53:22 opera systemd[1]: Reached target Graphical Interface. Dec 23 05:53:22 opera systemd[1]: Starting Update UTMP about System Runlevel Changes... Dec 23 05:53:22 opera volumio[1181]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 23 05:53:22 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:22 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:22 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:22 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:22 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:22 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:22 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:22 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:22 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:22 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:22 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:22 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:22 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:22 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:22 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:22 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:22 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:22 opera systemd[1]: Started Update UTMP about System Runlevel Changes. Dec 23 05:53:22 opera systemd[1]: Startup finished in 11.471s (kernel) + 2min 6.510s (userspace) = 2min 17.981s. Dec 23 05:53:22 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:22 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:22 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:22 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:22 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:22 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:22 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:22 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:22 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:22 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:22 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:22 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:22 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:22 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:23 opera ntfs-3g[2403]: Version 2014.2.15AR.2 integrated FUSE 28 Dec 23 05:53:23 opera ntfs-3g[2403]: Mounted /dev/sda1 (Read-Write, label "yy1", NTFS 3.1) Dec 23 05:53:23 opera ntfs-3g[2403]: Cmdline options: rw,nodev,nosuid,noatime,uid=1000,gid=1000,dmask=0077,fmask=0177,dmask=0000,fmask=0000,uhelper=udisks Dec 23 05:53:23 opera ntfs-3g[2403]: Mount options: rw,nodev,nosuid,uhelper=udisks,allow_other,nonempty,noatime,default_permissions,fsname=/dev/sda1,blkdev,blksize=4096 Dec 23 05:53:23 opera ntfs-3g[2403]: Global ownership and permissions enforced, configuration type 7 Dec 23 05:53:23 opera udisks-glue[680]: Successfully automounted /dev/sda1 at /media/yy1_ Dec 23 05:53:23 opera udisks-glue[680]: Device file /dev/sda1 mounted at /media/yy1_ Dec 23 05:53:23 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Dec 23 05:53:23 opera udisks-glue[680]: Updating DB (#32) ... Dec 23 05:53:23 opera udisks-glue[680]: volume: n/a repeat: off random: off single: off consume: off Dec 23 05:53:23 opera volumio[1181]: info: Dec 23 05:53:23 opera volumio[1181]: ---------------------------- MPD announces state update: update Dec 23 05:53:23 opera volumio[1181]: info: ControllerMpd::getState Dec 23 05:53:23 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Dec 23 05:53:23 opera volumio[1181]: info: sendMpdCommand status took 3 milliseconds Dec 23 05:53:23 opera volumio[1181]: info: sendMpdCommand status took 1 milliseconds Dec 23 05:53:23 opera volumio[1181]: verbose: ControllerMpd::parseState Dec 23 05:53:23 opera volumio[1181]: info: Command Router : Notfying DB Updatetrue Dec 23 05:53:23 opera volumio[1181]: info: CoreCommandRouter::Close All Modals sent Dec 23 05:53:23 opera volumio[1181]: verbose: ControllerMpd::parseState Dec 23 05:53:23 opera volumio[1181]: info: ControllerMpd::pushState Dec 23 05:53:23 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:23 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:23 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:23 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:23 opera volumio[1181]: info: CorePlayQueue::getTrack 1715 Dec 23 05:53:23 opera volumio[1181]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 23 05:53:23 opera volumio[1181]: verbose: CURRENT POSITION 1715 Dec 23 05:53:23 opera volumio[1181]: info: CoreStateMachine::syncState stateService stop Dec 23 05:53:23 opera volumio[1181]: info: CoreStateMachine::syncState currentStatus play Dec 23 05:53:23 opera volumio[1181]: info: CoreStateMachine::play index undefined Dec 23 05:53:23 opera volumio[1181]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 23 05:53:23 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:23 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:23 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:23 opera volumio[1181]: info: CorePlayQueue::getTrack 1538 Dec 23 05:53:23 opera volumio[1181]: info: CoreStateMachine::startPlaybackTimer Dec 23 05:53:23 opera volumio[1181]: info: CorePlayQueue::getTrack 1538 Dec 23 05:53:23 opera volumio[1181]: verbose: ControllerMpd::clearAddPlayTracks USB/yy1_/DSD/銀河歲月 DSD/09 Autumn Romance Medley.dsf Dec 23 05:53:23 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand stop Dec 23 05:53:23 opera volumio[1181]: info: ------------------------------ 48ms Dec 23 05:53:23 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:23 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:23 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:23 opera volumio[1181]: info: sendMpdCommand stop took 9 milliseconds Dec 23 05:53:23 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand clear Dec 23 05:53:23 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:23 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:23 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:23 opera volumio[1181]: info: Dec 23 05:53:23 opera volumio[1181]: ---------------------------- MPD announces system playlist update Dec 23 05:53:23 opera volumio[1181]: info: Ignoring MPD Status Update Dec 23 05:53:23 opera volumio[1181]: info: sendMpdCommand clear took 15 milliseconds Dec 23 05:53:23 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand add "USB/yy1_/DSD/銀河歲月 DSD/09 Autumn Romance Medley.dsf" Dec 23 05:53:23 opera volumio[1181]: error: updateQueue error: null Dec 23 05:53:23 opera volumio[1181]: info: ------------------------------ 2ms Dec 23 05:53:23 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:24 opera kernel: usb 1-1.2: USB disconnect, device number 48 Dec 23 05:53:24 opera kernel: sd 36:0:0:0: [sda] Synchronizing SCSI cache Dec 23 05:53:24 opera kernel: sd 36:0:0:0: [sda] tag#0 UNKNOWN(0x2003) Result: hostbyte=0x01 driverbyte=0x00 Dec 23 05:53:24 opera kernel: sd 36:0:0:0: [sda] tag#0 CDB: opcode=0x28 28 00 00 5e 2a 38 00 00 08 00 Dec 23 05:53:24 opera kernel: blk_update_request: I/O error, dev sda, sector 6171192 Dec 23 05:53:24 opera ntfs-3g[2403]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Dec 23 05:53:24 opera ntfs-3g[2403]: Failed to read index block: Input/output error Dec 23 05:53:24 opera udisks-glue[680]: Device file /dev/sda1 unmounted from /media/yy1_ Dec 23 05:53:24 opera udisks-glue[680]: Device file /dev/sda1 removed Dec 23 05:53:24 opera udisks-glue[680]: Device file /dev/sda removed Dec 23 05:53:24 opera kernel: sd 36:0:0:0: [sda] Synchronize Cache(10) failed: Result: hostbyte=0x01 driverbyte=0x00 Dec 23 05:53:24 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Dec 23 05:53:24 opera udisks-glue[680]: Updating DB (#33) ... Dec 23 05:53:24 opera udisks-glue[680]: volume: n/a repeat: off random: off single: off consume: off Dec 23 05:53:24 opera volumio[1181]: info: Dec 23 05:53:24 opera volumio[1181]: ---------------------------- MPD announces state update: update Dec 23 05:53:24 opera volumio[1181]: info: ControllerMpd::getState Dec 23 05:53:24 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Dec 23 05:53:24 opera volumio[1181]: info: sendMpdCommand status took 2 milliseconds Dec 23 05:53:24 opera volumio[1181]: verbose: ControllerMpd::parseState Dec 23 05:53:24 opera udisks-glue[680]: Updating DB (#34) ... Dec 23 05:53:24 opera udisks-glue[680]: volume: n/a repeat: off random: off single: off consume: off Dec 23 05:53:24 opera volumio[1181]: info: Command Router : Notfying DB Updatetrue Dec 23 05:53:24 opera volumio[1181]: info: CoreCommandRouter::Close All Modals sent Dec 23 05:53:24 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Dec 23 05:53:24 opera volumio[1181]: info: Dec 23 05:53:24 opera volumio[1181]: ---------------------------- MPD announces state update: update Dec 23 05:53:24 opera volumio[1181]: info: sendMpdCommand status took 34 milliseconds Dec 23 05:53:24 opera volumio[1181]: info: ControllerMpd::getState Dec 23 05:53:24 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Dec 23 05:53:24 opera volumio[1181]: verbose: ControllerMpd::parseState Dec 23 05:53:24 opera volumio[1181]: info: ControllerMpd::pushState Dec 23 05:53:24 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:24 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:24 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:24 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:24 opera volumio[1181]: info: CorePlayQueue::getTrack 1538 Dec 23 05:53:24 opera volumio[1181]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 23 05:53:24 opera volumio[1181]: verbose: CURRENT POSITION 1538 Dec 23 05:53:24 opera volumio[1181]: info: CoreStateMachine::syncState stateService stop Dec 23 05:53:24 opera volumio[1181]: info: CoreStateMachine::syncState currentStatus stop Dec 23 05:53:24 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:24 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:24 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:24 opera volumio[1181]: info: No code Dec 23 05:53:24 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:24 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:24 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:24 opera ntfs-3g[2403]: Unmounting /dev/sda1 (yy1) Dec 23 05:53:24 opera ntfs-3g[2403]: Failed to sync device /dev/sda1: Input/output error Dec 23 05:53:24 opera ntfs-3g[2403]: Failed to close volume /dev/sda1: Input/output error Dec 23 05:53:24 opera volumio[1181]: info: ------------------------------ 69ms Dec 23 05:53:24 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:24 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:24 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:24 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Dec 23 05:53:24 opera volumio[1181]: info: Dec 23 05:53:24 opera volumio[1181]: ---------------------------- MPD announces state update: update Dec 23 05:53:24 opera volumio[1181]: info: ControllerMpd::getState Dec 23 05:53:24 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Dec 23 05:53:24 opera volumio[1181]: info: sendMpdCommand status took 52 milliseconds Dec 23 05:53:24 opera volumio[1181]: info: sendMpdCommand status took 51 milliseconds Dec 23 05:53:24 opera volumio[1181]: verbose: ControllerMpd::parseState Dec 23 05:53:24 opera volumio[1181]: info: Command Router : Notfying DB Updatefalse Dec 23 05:53:24 opera volumio[1181]: info: CoreCommandRouter::Close All Modals sent Dec 23 05:53:24 opera volumio[1181]: verbose: ControllerMpd::parseState Dec 23 05:53:24 opera volumio[1181]: info: ControllerMpd::pushState Dec 23 05:53:24 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:24 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:24 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:24 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:24 opera volumio[1181]: info: CorePlayQueue::getTrack 1538 Dec 23 05:53:24 opera volumio[1181]: 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} Dec 23 05:53:24 opera volumio[1181]: verbose: CURRENT POSITION 1538 Dec 23 05:53:24 opera volumio[1181]: info: CoreStateMachine::syncState stateService stop Dec 23 05:53:24 opera volumio[1181]: info: CoreStateMachine::syncState currentStatus stop Dec 23 05:53:24 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:24 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:24 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:24 opera volumio[1181]: info: No code Dec 23 05:53:24 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:24 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:24 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:24 opera volumio[1181]: info: ------------------------------ 93ms Dec 23 05:53:24 opera volumio[1181]: info: sendMpdCommand status took 45 milliseconds Dec 23 05:53:24 opera volumio[1181]: info: sendMpdCommand status took 43 milliseconds Dec 23 05:53:24 opera volumio[1181]: verbose: ControllerMpd::parseState Dec 23 05:53:24 opera volumio[1181]: info: Command Router : Notfying DB Updatefalse Dec 23 05:53:24 opera volumio[1181]: info: CoreCommandRouter::Close All Modals sent Dec 23 05:53:24 opera volumio[1181]: verbose: ControllerMpd::parseState Dec 23 05:53:24 opera volumio[1181]: info: ControllerMpd::pushState Dec 23 05:53:24 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:24 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:24 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:24 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:24 opera volumio[1181]: info: CorePlayQueue::getTrack 1538 Dec 23 05:53:24 opera volumio[1181]: 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} Dec 23 05:53:24 opera volumio[1181]: verbose: CURRENT POSITION 1538 Dec 23 05:53:24 opera volumio[1181]: info: CoreStateMachine::syncState stateService stop Dec 23 05:53:24 opera volumio[1181]: info: CoreStateMachine::syncState currentStatus stop Dec 23 05:53:24 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:24 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:24 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:24 opera volumio[1181]: info: No code Dec 23 05:53:24 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:24 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:24 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:24 opera volumio[1181]: info: ------------------------------ 74ms Dec 23 05:53:24 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:24 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:24 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:24 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:24 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:24 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:24 opera kernel: usb 1-1.2: new high-speed USB device number 49 using dwc2 Dec 23 05:53:24 opera kernel: usb 1-1.2: New USB device found, idVendor=0480, idProduct=0826 Dec 23 05:53:24 opera kernel: usb 1-1.2: New USB device strings: Mfr=2, Product=3, SerialNumber=1 Dec 23 05:53:24 opera kernel: usb 1-1.2: Product: EXTERNAL_USB Dec 23 05:53:24 opera kernel: usb 1-1.2: Manufacturer: TOSHIBA Dec 23 05:53:24 opera kernel: usb 1-1.2: SerialNumber: 20220116005052F Dec 23 05:53:24 opera kernel: usb-storage 1-1.2:1.0: USB Mass Storage device detected Dec 23 05:53:24 opera kernel: scsi host37: usb-storage 1-1.2:1.0 Dec 23 05:53:24 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:25 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:25 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:25 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:25 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:25 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:25 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:25 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:25 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:25 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:25 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:25 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:25 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:25 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:25 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:25 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:25 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:25 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:25 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:25 opera kernel: usb 1-1.2: USB disconnect, device number 49 Dec 23 05:53:25 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:25 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:25 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:25 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:25 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:25 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:25 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:25 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:25 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:25 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:25 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:25 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:25 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:26 opera shairport-sync[1679]: {"time":1766469124359,"response":"airplayActive Success"}ALSA lib pcm.c:8309:(snd_pcm_recover) cannot recovery from underrun, prepare failed: No such device Dec 23 05:53:26 opera shairport-sync[1679]: alsa: can't recover from SND_PCM_STATE_XRUN: No such device. Dec 23 05:53:26 opera kernel: usb 1-1-port3: disabled by hub (EMI?), re-enabling... Dec 23 05:53:26 opera kernel: usb 1-1.3: USB disconnect, device number 3 Dec 23 05:53:26 opera kernel: usb 1-1.3: cannot submit urb (err = -19) Dec 23 05:53:26 opera kernel: usb 1-1.3: 3:2: cannot set freq 44100 to ep 0x3 Dec 23 05:53:26 opera shairport-sync[1679]: ALSA lib pcm.c:8309:(snd_pcm_recover) cannot recovery from underrun, prepare failed: No such device Dec 23 05:53:26 opera shairport-sync[1679]: alsa: can't recover from SND_PCM_STATE_XRUN: No such device. Dec 23 05:53:26 opera kernel: usb 1-1.3: 3:2: cannot set freq 44100 to ep 0x3 Dec 23 05:53:26 opera shairport-sync[1679]: ALSA lib pcm.c:8309:(snd_pcm_recover) cannot recovery from underrun, prepare failed: No such device Dec 23 05:53:26 opera shairport-sync[1679]: alsa: can't recover from SND_PCM_STATE_XRUN: No such device. Dec 23 05:53:26 opera kernel: usb 1-1.3: 3:2: cannot set freq 44100 to ep 0x3 Dec 23 05:53:26 opera shairport-sync[1679]: ALSA lib pcm.c:8309:(snd_pcm_recover) cannot recovery from underrun, prepare failed: No such device Dec 23 05:53:26 opera shairport-sync[1679]: alsa: can't recover from SND_PCM_STATE_XRUN: No such device. Dec 23 05:53:26 opera shairport-sync[1679]: ALSA lib pcm.c:8309:(snd_pcm_recover) cannot recovery from underrun, prepare failed: No such device Dec 23 05:53:26 opera kernel: usb 1-1.3: 3:2: cannot set freq 44100 to ep 0x3 Dec 23 05:53:26 opera kernel: usb 1-1.3: 3:2: cannot set freq 44100 to ep 0x3 Dec 23 05:53:26 opera shairport-sync[1679]: alsa: can't recover from SND_PCM_STATE_XRUN: No such device. Dec 23 05:53:26 opera volumio[1181]: info: Dec 23 05:53:26 opera volumio[1181]: ---------------------------- USB Audio Device Detached Dec 23 05:53:26 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Dec 23 05:53:26 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 23 05:53:26 opera volumio[1181]: No protocol specified Dec 23 05:53:26 opera volumio[1181]: xcb_connection_has_error() returned true Dec 23 05:53:26 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Dec 23 05:53:26 opera volumio[1181]: info: Stopping RAAT Plugin Dec 23 05:53:26 opera sudo[2442]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop raat-daemon.service Dec 23 05:53:26 opera sudo[2442]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 23 05:53:26 opera systemd[1]: Stopping RAAT DAEMON... Dec 23 05:53:26 opera systemd[1]: Stopped RAAT DAEMON. Dec 23 05:53:26 opera volumio[1181]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 23 05:53:26 opera sudo[2442]: pam_unix(sudo:session): session closed for user root Dec 23 05:53:26 opera volumio[1181]: info: Raat Daemon stopped successfully Dec 23 05:53:26 opera kernel: usb 1-1.3: new full-speed USB device number 50 using dwc2 Dec 23 05:53:26 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:27 opera kernel: usb 1-1.3: config 1 has an invalid interface number: 3 but max is 2 Dec 23 05:53:27 opera kernel: usb 1-1.3: config 1 has an invalid interface number: 3 but max is 2 Dec 23 05:53:27 opera kernel: usb 1-1.3: config 1 has an invalid interface number: 3 but max is 2 Dec 23 05:53:27 opera kernel: usb 1-1.3: config 1 has no interface number 2 Dec 23 05:53:27 opera kernel: usb 1-1.3: New USB device found, idVendor=0000, idProduct=0151 Dec 23 05:53:27 opera kernel: usb 1-1.3: New USB device strings: Mfr=1, Product=2, SerialNumber=0 Dec 23 05:53:27 opera kernel: usb 1-1.3: Product: USB Audio Input Dec 23 05:53:27 opera kernel: usb 1-1.3: Manufacturer: WADIA DIGITAL Dec 23 05:53:27 opera kernel: input: WADIA DIGITAL USB Audio Input as /devices/platform/ff540000.usb/usb1/1-1/1-1.3/1-1.3:1.0/0003:0000:0151.0003/input/input4 Dec 23 05:53:27 opera kernel: hid-generic 0003:0000:0151.0003: input,hidraw1: USB HID v1.00 Device [WADIA DIGITAL USB Audio Input] on usb-ff540000.usb-1.3/input0 Dec 23 05:53:27 opera volumio[1181]: info: Dec 23 05:53:27 opera volumio[1181]: ---------------------------- USB Audio Device Attached Dec 23 05:53:27 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Dec 23 05:53:27 opera volumio[1181]: No protocol specified Dec 23 05:53:27 opera volumio[1181]: xcb_connection_has_error() returned true Dec 23 05:53:27 opera volumio[1181]: info: CoreCommandRouter::Close All Modals sent Dec 23 05:53:27 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 23 05:53:27 opera volumio[1181]: info: Output device has changed, restarting MPD Dec 23 05:53:27 opera sudo[2465]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 23 05:53:27 opera volumio[1181]: info: Output device has changed, restarting Shairport Sync Dec 23 05:53:27 opera sudo[2465]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 23 05:53:27 opera sudo[2465]: pam_unix(sudo:session): session closed for user root Dec 23 05:53:27 opera sudo[2469]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 23 05:53:27 opera sudo[2469]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 23 05:53:27 opera systemd[1]: Stopping Music Player Daemon... Dec 23 05:53:27 opera volumio[1181]: No protocol specified Dec 23 05:53:27 opera volumio[1181]: xcb_connection_has_error() returned true Dec 23 05:53:27 opera volumio[1181]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Dec 23 05:53:27 opera volumio[1181]: No protocol specified Dec 23 05:53:27 opera volumio[1181]: xcb_connection_has_error() returned true Dec 23 05:53:27 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 23 05:53:27 opera kernel: usb 1-1.2: new high-speed USB device number 51 using dwc2 Dec 23 05:53:27 opera volumio[1181]: No protocol specified Dec 23 05:53:27 opera volumio[1181]: xcb_connection_has_error() returned true Dec 23 05:53:27 opera volumio[1181]: info: Setting mixer PCM for card USB Audio Input Dec 23 05:53:27 opera volumio[1181]: info: Reconfiguring and Restarting RAAT Plugin due to audio path changes Dec 23 05:53:27 opera systemd[1]: Starting Music Player Daemon... Dec 23 05:53:27 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:27 opera volumio[1181]: No protocol specified Dec 23 05:53:27 opera volumio[1181]: xcb_connection_has_error() returned true Dec 23 05:53:28 opera volumio[1181]: info: CoreCommandRouter::volumioUpdateVolumeSettings Dec 23 05:53:28 opera volumio[1181]: info: Updating Volume Controller Parameters: Device: 5 Name: Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 10 Dec 23 05:53:28 opera volumio[1181]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 23 05:53:28 opera volumio[1181]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 23 05:53:28 opera volumio[1181]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 23 05:53:28 opera volumio[1181]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 23 05:53:28 opera volumio[1181]: info: MPD Permissions set Dec 23 05:53:28 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 05:53:28 opera volumio[1181]: info: CoreCommandRouter::volumioGetState Dec 23 05:53:28 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 05:53:28 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 05:53:28 opera volumio[1181]: info: CoreCommandRouter::volumioGetState Dec 23 05:53:28 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 05:53:28 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 05:53:28 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 05:53:28 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 05:53:28 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 05:53:28 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 05:53:28 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 05:53:28 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 05:53:28 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 23 05:53:28 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Dec 23 05:53:28 opera kernel: usb 1-1.2: New USB device found, idVendor=0480, idProduct=0826 Dec 23 05:53:28 opera kernel: usb 1-1.2: New USB device strings: Mfr=2, Product=3, SerialNumber=1 Dec 23 05:53:28 opera kernel: usb 1-1.2: Product: EXTERNAL_USB Dec 23 05:53:28 opera kernel: usb 1-1.2: Manufacturer: TOSHIBA Dec 23 05:53:28 opera kernel: usb 1-1.2: SerialNumber: 20220116005052F Dec 23 05:53:28 opera kernel: usb-storage 1-1.2:1.0: USB Mass Storage device detected Dec 23 05:53:28 opera kernel: scsi host38: usb-storage 1-1.2:1.0 Dec 23 05:53:28 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 05:53:28 opera volumio[1181]: No protocol specified Dec 23 05:53:28 opera volumio[1181]: xcb_connection_has_error() returned true Dec 23 05:53:28 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Dec 23 05:53:28 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 23 05:53:28 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 23 05:53:28 opera volumio[1181]: No protocol specified Dec 23 05:53:28 opera volumio[1181]: xcb_connection_has_error() returned true Dec 23 05:53:28 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 23 05:53:28 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 23 05:53:28 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 23 05:53:28 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 23 05:53:28 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 23 05:53:28 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 23 05:53:28 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 23 05:53:28 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Dec 23 05:53:28 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 23 05:53:28 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: raat , getAdditionalUiSection Dec 23 05:53:28 opera volumio[1181]: info: Starting Shairport Sync Dec 23 05:53:28 opera volumio[1181]: [SpotifyConnect] Restarting Vollibrespot Daemon Dec 23 05:53:28 opera volumio[1181]: [SpotifyConnect] Restarting Vollibrespot Daemon Dec 23 05:53:28 opera sudo[2518]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 23 05:53:28 opera sudo[2518]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 23 05:53:28 opera volumio[1181]: error: Upnp client error: Error: This socket has been ended by the other party Dec 23 05:53:28 opera volumio[1181]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: No protocol specified Dec 23 05:53:28 opera volumio[1181]: xcb_connection_has_error() returned true Dec 23 05:53:28 opera sudo[2521]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect2.service Dec 23 05:53:28 opera systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 23 05:53:28 opera systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Dec 23 05:53:28 opera systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 23 05:53:28 opera sudo[2518]: pam_unix(sudo:session): session closed for user root Dec 23 05:53:28 opera volumio[1181]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 23 05:53:28 opera volumio[1181]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 23 05:53:28 opera sudo[2521]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 23 05:53:28 opera sudo[2527]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect2.service Dec 23 05:53:28 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 05:53:28 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 05:53:28 opera sudo[2527]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 23 05:53:28 opera systemd[1]: Stopping Volspotconnect2 Daemon... Dec 23 05:53:28 opera volumio[1181]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 23 05:53:28 opera volumio[1181]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 23 05:53:28 opera volumio[1181]: info: Shairport-Sync Started Dec 23 05:53:28 opera kernel: usb 1-1.2: USB disconnect, device number 51 Dec 23 05:53:28 opera systemd[1]: Starting Volspotconnect2 Daemon... Dec 23 05:53:28 opera systemd[1]: Started Volspotconnect2 Daemon. Dec 23 05:53:28 opera sudo[2521]: pam_unix(sudo:session): session closed for user root Dec 23 05:53:28 opera volumio[2552]: vollibrespot v0.1.9 c98fd5d 2019-11-08 (librespot 4674946 2019-11-08) -- Built On 2019-11-08 Dec 23 05:53:28 opera systemd[1]: Stopping Volspotconnect2 Daemon... Dec 23 05:53:28 opera systemd[1]: Starting Volspotconnect2 Daemon... Dec 23 05:53:28 opera systemd[1]: Started Volspotconnect2 Daemon. Dec 23 05:53:28 opera sudo[2527]: pam_unix(sudo:session): session closed for user root Dec 23 05:53:28 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 05:53:28 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 05:53:28 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 05:53:28 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 23 05:53:28 opera volumio[1181]: info: Not Reporting Auto name since its the default one Dec 23 05:53:28 opera volumio[1181]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 23 05:53:28 opera volumio[2565]: vollibrespot v0.1.9 c98fd5d 2019-11-08 (librespot 4674946 2019-11-08) -- Built On 2019-11-08 Dec 23 05:53:28 opera volumio[1181]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 23 05:53:28 opera volumio[1181]: [SpotifyConnect] null Dec 23 05:53:28 opera volumio[1181]: info: VolumeController:: Volume=undefined Mute =false Dec 23 05:53:28 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:28 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:28 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:28 opera volumio[2565]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Other, message: "No such device" } Dec 23 05:53:28 opera sudo[2574]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect2.service Dec 23 05:53:28 opera sudo[2574]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 23 05:53:28 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 05:53:28 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 05:53:28 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 05:53:28 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 23 05:53:28 opera volumio[1181]: info: Not Reporting Auto name since its the default one Dec 23 05:53:28 opera volumio[1181]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Dec 23 05:53:28 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:28 opera volumio[1181]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Dec 23 05:53:28 opera volumio[1181]: [SpotifyConnect] null Dec 23 05:53:28 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Dec 23 05:53:28 opera systemd[1]: Started Volspotconnect2 Daemon. Dec 23 05:53:28 opera sudo[2574]: pam_unix(sudo:session): session closed for user root Dec 23 05:53:28 opera sudo[2584]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect2.service Dec 23 05:53:28 opera systemd[1]: Started Music Player Daemon. Dec 23 05:53:28 opera sudo[2469]: pam_unix(sudo:session): session closed for user root Dec 23 05:53:28 opera sudo[2584]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 23 05:53:28 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 05:53:28 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 05:53:28 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 05:53:28 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 23 05:53:28 opera volumio[1181]: info: Not Reporting Auto name since its the default one Dec 23 05:53:28 opera volumio[1181]: [SpotifyConnect] Vollibrespot Daemon Started Dec 23 05:53:28 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Dec 23 05:53:28 opera sudo[2584]: pam_unix(sudo:session): session closed for user root Dec 23 05:53:28 opera systemd[1]: Started Volspotconnect2 Daemon. Dec 23 05:53:28 opera volumio[1181]: No protocol specified Dec 23 05:53:28 opera volumio[1181]: xcb_connection_has_error() returned true Dec 23 05:53:28 opera volumio[1181]: [SpotifyConnect] Vollibrespot Daemon Started Dec 23 05:53:28 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Dec 23 05:53:28 opera sudo[2613]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Dec 23 05:53:28 opera sudo[2613]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 23 05:53:28 opera systemd[1]: Starting RAAT DAEMON... Dec 23 05:53:28 opera systemd[1]: Started RAAT DAEMON. Dec 23 05:53:28 opera volumio[1181]: No protocol specified Dec 23 05:53:28 opera volumio[1181]: xcb_connection_has_error() returned true Dec 23 05:53:28 opera sudo[2613]: pam_unix(sudo:session): session closed for user root Dec 23 05:53:28 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Dec 23 05:53:28 opera sudo[2639]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Dec 23 05:53:28 opera sudo[2639]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 23 05:53:28 opera volumio[1181]: No protocol specified Dec 23 05:53:28 opera volumio[1181]: xcb_connection_has_error() returned true Dec 23 05:53:28 opera systemd[1]: Stopping RAAT DAEMON... Dec 23 05:53:28 opera systemd[1]: Starting RAAT DAEMON... Dec 23 05:53:28 opera systemd[1]: Started RAAT DAEMON. Dec 23 05:53:28 opera sudo[2639]: pam_unix(sudo:session): session closed for user root Dec 23 05:53:28 opera sudo[2661]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Dec 23 05:53:28 opera volumio[1181]: error: updateQueue error: null Dec 23 05:53:28 opera volumio[1181]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 23 05:53:28 opera volumio[1181]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 23 05:53:28 opera sudo[2661]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 23 05:53:28 opera volumio[1181]: info: Raat Daemon started successfully Dec 23 05:53:28 opera volumio[1181]: info: Raat Daemon started successfully Dec 23 05:53:28 opera volumio[1181]: info: Executing endpoint restartRAATSocket Dec 23 05:53:28 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Dec 23 05:53:28 opera systemd[1]: Stopping RAAT DAEMON... Dec 23 05:53:28 opera systemd[1]: Starting RAAT DAEMON... Dec 23 05:53:28 opera systemd[1]: Started RAAT DAEMON. Dec 23 05:53:28 opera sudo[2661]: pam_unix(sudo:session): session closed for user root Dec 23 05:53:28 opera volumio[1181]: info: Executing endpoint restartRAATSocket Dec 23 05:53:28 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Dec 23 05:53:28 opera volumio[1181]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 23 05:53:28 opera volumio[1181]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 23 05:53:28 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:28 opera volumio[1181]: info: Raat Daemon started successfully Dec 23 05:53:29 opera volumio[1181]: info: Executing endpoint restartRAATSocket Dec 23 05:53:29 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Dec 23 05:53:29 opera kernel: usb 1-1.2: new high-speed USB device number 52 using dwc2 Dec 23 05:53:29 opera kernel: usb 1-1.2: New USB device found, idVendor=0480, idProduct=0826 Dec 23 05:53:29 opera kernel: usb 1-1.2: New USB device strings: Mfr=2, Product=3, SerialNumber=1 Dec 23 05:53:29 opera kernel: usb 1-1.2: Product: EXTERNAL_USB Dec 23 05:53:29 opera kernel: usb 1-1.2: Manufacturer: TOSHIBA Dec 23 05:53:29 opera kernel: usb 1-1.2: SerialNumber: 20220116005052F Dec 23 05:53:29 opera kernel: usb-storage 1-1.2:1.0: USB Mass Storage device detected Dec 23 05:53:29 opera kernel: scsi host39: usb-storage 1-1.2:1.0 Dec 23 05:53:29 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:30 opera volumio[1181]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Dec 23 05:53:30 opera volumio[1181]: info: CoreStateMachine::getcurrentVolume Dec 23 05:53:30 opera volumio[1181]: info: CoreCommandRouter::volumioRetrievevolume Dec 23 05:53:30 opera volumio[1181]: info: VolumeController:: Volume=47 Mute =false Dec 23 05:53:30 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:30 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:30 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:30 opera volumio[1181]: info: CoreStateMachine::updateTrackBlock Dec 23 05:53:30 opera volumio[1181]: info: CorePlayQueue::getTrackBlock Dec 23 05:53:30 opera volumio[1181]: info: CoreCommandRouter::volumioRetrievevolume Dec 23 05:53:30 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:30 opera volumio[1181]: info: VolumeController:: Volume=47 Mute =false Dec 23 05:53:30 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:30 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:30 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:30 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:30 opera kernel: scsi 39:0:0:0: Direct-Access TOSHIBA EXTERNAL_USB 0 PQ: 0 ANSI: 6 Dec 23 05:53:30 opera kernel: sd 39:0:0:0: [sda] Spinning up disk... Dec 23 05:53:30 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:31 opera kernel: .ready Dec 23 05:53:31 opera kernel: sd 39:0:0:0: [sda] 1953525168 512-byte logical blocks: (1.00 TB/932 GiB) Dec 23 05:53:31 opera kernel: sd 39:0:0:0: [sda] Write Protect is off Dec 23 05:53:31 opera kernel: sd 39:0:0:0: [sda] Mode Sense: 43 00 00 00 Dec 23 05:53:31 opera kernel: sd 39:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA Dec 23 05:53:31 opera kernel: sda: sda1 Dec 23 05:53:31 opera kernel: sd 39:0:0:0: [sda] Attached SCSI disk Dec 23 05:53:31 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:32 opera udisks-glue[680]: Device file /dev/sda inserted Dec 23 05:53:32 opera udisks-glue[680]: Device file /dev/sda1 inserted Dec 23 05:53:32 opera udisks-glue[680]: Trying to automount /dev/sda1... Dec 23 05:53:32 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:33 opera ntfs-3g[2702]: Version 2014.2.15AR.2 integrated FUSE 28 Dec 23 05:53:33 opera ntfs-3g[2702]: Mounted /dev/sda1 (Read-Write, label "yy1", NTFS 3.1) Dec 23 05:53:33 opera ntfs-3g[2702]: Cmdline options: rw,nodev,nosuid,noatime,uid=1000,gid=1000,dmask=0077,fmask=0177,dmask=0000,fmask=0000,uhelper=udisks Dec 23 05:53:33 opera ntfs-3g[2702]: Mount options: rw,nodev,nosuid,uhelper=udisks,allow_other,nonempty,noatime,default_permissions,fsname=/dev/sda1,blkdev,blksize=4096 Dec 23 05:53:33 opera ntfs-3g[2702]: Global ownership and permissions enforced, configuration type 7 Dec 23 05:53:33 opera udisks-glue[680]: Successfully automounted /dev/sda1 at /media/yy1_ Dec 23 05:53:33 opera udisks-glue[680]: Device file /dev/sda1 mounted at /media/yy1_ Dec 23 05:53:33 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Dec 23 05:53:33 opera volumio[1181]: info: Dec 23 05:53:33 opera volumio[1181]: ---------------------------- MPD announces state update: update Dec 23 05:53:33 opera volumio[1181]: info: ControllerMpd::getState Dec 23 05:53:33 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Dec 23 05:53:33 opera volumio[1181]: info: sendMpdCommand status took 10 milliseconds Dec 23 05:53:33 opera volumio[1181]: verbose: ControllerMpd::parseState Dec 23 05:53:33 opera udisks-glue[680]: Updating DB (#1) ... Dec 23 05:53:33 opera udisks-glue[680]: volume: n/a repeat: off random: off single: off consume: off Dec 23 05:53:33 opera volumio[1181]: info: Command Router : Notfying DB Updatetrue Dec 23 05:53:33 opera volumio[1181]: info: CoreCommandRouter::Close All Modals sent Dec 23 05:53:33 opera volumio[1181]: info: sendMpdCommand status took 39 milliseconds Dec 23 05:53:33 opera volumio[1181]: verbose: ControllerMpd::parseState Dec 23 05:53:33 opera volumio[1181]: info: ControllerMpd::pushState Dec 23 05:53:33 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:33 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:33 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:33 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:33 opera volumio[1181]: info: CorePlayQueue::getTrack 1538 Dec 23 05:53:33 opera volumio[1181]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 23 05:53:33 opera volumio[1181]: verbose: CURRENT POSITION 1538 Dec 23 05:53:33 opera volumio[1181]: info: CoreStateMachine::syncState stateService stop Dec 23 05:53:33 opera volumio[1181]: info: CoreStateMachine::syncState currentStatus play Dec 23 05:53:33 opera volumio[1181]: info: CoreStateMachine::play index undefined Dec 23 05:53:33 opera volumio[1181]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 23 05:53:33 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:33 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:33 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:33 opera volumio[1181]: info: CorePlayQueue::getTrack 1141 Dec 23 05:53:33 opera volumio[1181]: info: CoreStateMachine::startPlaybackTimer Dec 23 05:53:33 opera volumio[1181]: info: CorePlayQueue::getTrack 1141 Dec 23 05:53:33 opera volumio[1181]: verbose: ControllerMpd::clearAddPlayTracks USB/yy1_/DSD/王菲 - 天空 SACD（香港版）/王菲 - 天空 - 14 - 靜夜的單簧管 .dsf Dec 23 05:53:33 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand stop Dec 23 05:53:33 opera volumio[1181]: info: ------------------------------ 52ms Dec 23 05:53:33 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:33 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:33 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:33 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:33 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:33 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:33 opera volumio[1181]: info: sendMpdCommand stop took 20 milliseconds Dec 23 05:53:33 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand clear Dec 23 05:53:33 opera volumio[1181]: info: Dec 23 05:53:33 opera volumio[1181]: ---------------------------- MPD announces system playlist update Dec 23 05:53:33 opera volumio[1181]: info: Ignoring MPD Status Update Dec 23 05:53:33 opera volumio[1181]: info: sendMpdCommand clear took 1 milliseconds Dec 23 05:53:33 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand add "USB/yy1_/DSD/王菲 - 天空 SACD（香港版）/王菲 - 天空 - 14 - 靜夜的單簧管 .dsf" Dec 23 05:53:33 opera volumio[1181]: error: updateQueue error: null Dec 23 05:53:33 opera volumio[1181]: info: ------------------------------ 1ms Dec 23 05:53:33 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:34 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:35 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:35 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:35 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:35 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:35 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:35 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:35 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:35 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:35 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:35 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:35 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:35 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:35 opera shairport-sync[2531]: Failed to create secure directory (/home/shairport-sync/.config/pulse): No such file or directory Dec 23 05:53:35 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:35 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:35 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:35 opera volumio[1181]: info: Airplay started streaming, receiving metadatas Dec 23 05:53:35 opera volumio[1181]: info: Airplay started streaming, receiving metadatas Dec 23 05:53:35 opera volumio[1181]: info: Airplay started streaming, receiving metadatas Dec 23 05:53:35 opera shairport-sync[2531]: % Total % Received % Xferd Average Speed Time Time Time Current Dec 23 05:53:35 opera shairport-sync[2531]: Dload Upload Total Spent Left Speed Dec 23 05:53:35 opera volumio[1181]: info: Dec 23 05:53:35 opera volumio[1181]: ---------------------------- Client requests Start Airplay PlaybackRoutine Dec 23 05:53:35 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startAirplayPlayback Dec 23 05:53:35 opera volumio[1181]: info: Airplay playback start Dec 23 05:53:35 opera shairport-sync[2531]: [155B blob data] Dec 23 05:53:35 opera shairport-sync[2531]: {"time":1766469215194,"response":"startAirplayPlayback Success"} % Total % Received % Xferd Average Speed Time Time Time Current Dec 23 05:53:35 opera shairport-sync[2531]: Dload Upload Total Spent Left Speed Dec 23 05:53:35 opera volumio[1181]: info: Dec 23 05:53:35 opera volumio[1181]: ---------------------------- Client requests AirplayActive Dec 23 05:53:35 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , setAirplayActive Dec 23 05:53:35 opera shairport-sync[2531]: [155B blob data] Dec 23 05:53:35 opera kernel: usb 1-1.2: USB disconnect, device number 52 Dec 23 05:53:35 opera kernel: sd 39:0:0:0: [sda] Synchronizing SCSI cache Dec 23 05:53:35 opera ntfs-3g[2702]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Dec 23 05:53:35 opera ntfs-3g[2702]: ntfs_attr_pread error reading '/DSD/Anita Mui - 赤色梅艷芳/04 - 再共舞.dsf' at offset 0: 16384 <> -1: Input/output error Dec 23 05:53:35 opera ntfs-3g[2702]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Dec 23 05:53:35 opera ntfs-3g[2702]: ntfs_attr_pread error reading '/DSD/Anita Mui - 赤色梅艷芳/04 - 再共舞.dsf' at offset 0: 4096 <> -1: Input/output error Dec 23 05:53:35 opera udisks-glue[680]: Device file /dev/sda1 unmounted from /media/yy1_ Dec 23 05:53:35 opera udisks-glue[680]: Device file /dev/sda1 removed Dec 23 05:53:35 opera udisks-glue[680]: Device file /dev/sda removed Dec 23 05:53:35 opera kernel: sd 39:0:0:0: [sda] tag#0 UNKNOWN(0x2003) Result: hostbyte=0x01 driverbyte=0x00 Dec 23 05:53:35 opera kernel: sd 39:0:0:0: [sda] tag#0 CDB: opcode=0x28 28 00 02 66 41 f8 00 00 20 00 Dec 23 05:53:35 opera kernel: blk_update_request: I/O error, dev sda, sector 40255992 Dec 23 05:53:35 opera kernel: sd 39:0:0:0: [sda] Synchronize Cache(10) failed: Result: hostbyte=0x01 driverbyte=0x00 Dec 23 05:53:35 opera kernel: Buffer I/O error on dev sda1, logical block 5031743, async page read Dec 23 05:53:35 opera kernel: Buffer I/O error on dev sda1, logical block 5031743, async page read Dec 23 05:53:35 opera udisks-glue[680]: Updating DB (#1) ... Dec 23 05:53:35 opera udisks-glue[680]: volume: n/a repeat: off random: off single: off consume: off Dec 23 05:53:35 opera udisks-glue[680]: Updating DB (#1) ... Dec 23 05:53:35 opera udisks-glue[680]: volume: n/a repeat: off random: off single: off consume: off Dec 23 05:53:35 opera volumio[1181]: info: MPD Database updated - AlbumList cache refreshed Dec 23 05:53:35 opera volumio[1181]: info: Dec 23 05:53:35 opera volumio[1181]: ---------------------------- MPD announces state update: database Dec 23 05:53:35 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Dec 23 05:53:35 opera volumio[1181]: info: Dec 23 05:53:35 opera volumio[1181]: ---------------------------- MPD announces state update: update Dec 23 05:53:35 opera volumio[1181]: info: ControllerMpd::getState Dec 23 05:53:35 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Dec 23 05:53:35 opera volumio[1181]: info: ControllerMpd::getState Dec 23 05:53:35 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Dec 23 05:53:35 opera volumio[1181]: info: sendMpdCommand status took 22 milliseconds Dec 23 05:53:35 opera ntfs-3g[2702]: Unmounting /dev/sda1 (yy1) Dec 23 05:53:35 opera ntfs-3g[2702]: Failed to sync device /dev/sda1: Input/output error Dec 23 05:53:35 opera ntfs-3g[2702]: Failed to close volume /dev/sda1: Input/output error Dec 23 05:53:35 opera volumio[1181]: info: sendMpdCommand status took 30 milliseconds Dec 23 05:53:35 opera volumio[1181]: verbose: ControllerMpd::parseState Dec 23 05:53:35 opera volumio[1181]: info: Command Router : Notfying DB Updatetrue Dec 23 05:53:35 opera volumio[1181]: info: CoreCommandRouter::Close All Modals sent Dec 23 05:53:35 opera volumio[1181]: verbose: ControllerMpd::parseState Dec 23 05:53:35 opera volumio[1181]: info: ControllerMpd::pushState Dec 23 05:53:35 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:35 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:35 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:35 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:35 opera volumio[1181]: info: CorePlayQueue::getTrack 1141 Dec 23 05:53:35 opera volumio[1181]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 23 05:53:35 opera volumio[1181]: verbose: CURRENT POSITION 1141 Dec 23 05:53:35 opera volumio[1181]: info: CoreStateMachine::syncState stateService stop Dec 23 05:53:35 opera volumio[1181]: info: CoreStateMachine::syncState currentStatus play Dec 23 05:53:35 opera volumio[1181]: info: CoreStateMachine::play index undefined Dec 23 05:53:35 opera volumio[1181]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 23 05:53:35 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:35 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:35 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:35 opera volumio[1181]: info: CorePlayQueue::getTrack 1297 Dec 23 05:53:35 opera volumio[1181]: info: CoreStateMachine::startPlaybackTimer Dec 23 05:53:35 opera volumio[1181]: info: CorePlayQueue::getTrack 1297 Dec 23 05:53:35 opera volumio[1181]: verbose: ControllerMpd::clearAddPlayTracks USB/yy1_/DSD/羅時豐 唱歌的人 SACD/10 - 夜空.dff Dec 23 05:53:35 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand stop Dec 23 05:53:35 opera volumio[1181]: info: ------------------------------ 79ms Dec 23 05:53:35 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:35 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:35 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:35 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Dec 23 05:53:35 opera volumio[1181]: info: Dec 23 05:53:35 opera volumio[1181]: ---------------------------- MPD announces state update: update Dec 23 05:53:35 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Dec 23 05:53:35 opera volumio[1181]: info: Dec 23 05:53:35 opera volumio[1181]: ---------------------------- MPD announces state update: update Dec 23 05:53:35 opera volumio[1181]: info: sendMpdCommand status took 94 milliseconds Dec 23 05:53:35 opera volumio[1181]: info: ControllerMpd::getState Dec 23 05:53:35 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Dec 23 05:53:35 opera volumio[1181]: info: sendMpdCommand stop took 18 milliseconds Dec 23 05:53:35 opera volumio[1181]: info: ControllerMpd::getState Dec 23 05:53:35 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Dec 23 05:53:35 opera volumio[1181]: verbose: ControllerMpd::parseState Dec 23 05:53:35 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand clear Dec 23 05:53:35 opera volumio[1181]: info: ControllerMpd::pushState Dec 23 05:53:35 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:35 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:35 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:35 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:35 opera volumio[1181]: info: CorePlayQueue::getTrack 1297 Dec 23 05:53:35 opera volumio[1181]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 23 05:53:35 opera volumio[1181]: verbose: CURRENT POSITION 1297 Dec 23 05:53:35 opera volumio[1181]: info: CoreStateMachine::syncState stateService stop Dec 23 05:53:35 opera volumio[1181]: info: CoreStateMachine::syncState currentStatus stop Dec 23 05:53:35 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:35 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:35 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:35 opera volumio[1181]: info: No code Dec 23 05:53:35 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:35 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:35 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:35 opera volumio[1181]: info: ------------------------------ 107ms Dec 23 05:53:35 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:35 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:35 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:35 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:35 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:35 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:35 opera volumio[1181]: info: Dec 23 05:53:35 opera volumio[1181]: ---------------------------- MPD announces system playlist update Dec 23 05:53:35 opera volumio[1181]: info: Ignoring MPD Status Update Dec 23 05:53:35 opera volumio[1181]: info: sendMpdCommand status took 32 milliseconds Dec 23 05:53:35 opera volumio[1181]: info: sendMpdCommand status took 31 milliseconds Dec 23 05:53:35 opera volumio[1181]: info: sendMpdCommand status took 31 milliseconds Dec 23 05:53:35 opera volumio[1181]: info: sendMpdCommand status took 31 milliseconds Dec 23 05:53:35 opera volumio[1181]: info: sendMpdCommand clear took 30 milliseconds Dec 23 05:53:35 opera volumio[1181]: verbose: ControllerMpd::parseState Dec 23 05:53:35 opera volumio[1181]: info: Command Router : Notfying DB Updatefalse Dec 23 05:53:35 opera volumio[1181]: info: CoreCommandRouter::Close All Modals sent Dec 23 05:53:35 opera volumio[1181]: verbose: ControllerMpd::parseState Dec 23 05:53:35 opera volumio[1181]: info: Command Router : Notfying DB Updatefalse Dec 23 05:53:35 opera volumio[1181]: info: CoreCommandRouter::Close All Modals sent Dec 23 05:53:35 opera volumio[1181]: verbose: ControllerMpd::parseState Dec 23 05:53:35 opera volumio[1181]: verbose: ControllerMpd::parseState Dec 23 05:53:35 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand add "USB/yy1_/DSD/羅時豐 唱歌的人 SACD/10 - 夜空.dff" Dec 23 05:53:35 opera volumio[1181]: info: ControllerMpd::pushState Dec 23 05:53:35 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:35 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:35 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:35 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:35 opera volumio[1181]: info: CorePlayQueue::getTrack 1297 Dec 23 05:53:35 opera volumio[1181]: 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} Dec 23 05:53:35 opera volumio[1181]: verbose: CURRENT POSITION 1297 Dec 23 05:53:35 opera volumio[1181]: info: CoreStateMachine::syncState stateService stop Dec 23 05:53:35 opera volumio[1181]: info: CoreStateMachine::syncState currentStatus stop Dec 23 05:53:35 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:35 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:35 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:35 opera volumio[1181]: info: No code Dec 23 05:53:35 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:35 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:35 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:35 opera volumio[1181]: info: ControllerMpd::pushState Dec 23 05:53:35 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:35 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:35 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:35 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:35 opera volumio[1181]: info: CorePlayQueue::getTrack 1297 Dec 23 05:53:35 opera volumio[1181]: 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} Dec 23 05:53:35 opera volumio[1181]: verbose: CURRENT POSITION 1297 Dec 23 05:53:35 opera volumio[1181]: info: CoreStateMachine::syncState stateService stop Dec 23 05:53:35 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:36 opera kernel: usb 1-1.2: new high-speed USB device number 53 using dwc2 Dec 23 05:53:36 opera kernel: usb 1-1.2: New USB device found, idVendor=0480, idProduct=0826 Dec 23 05:53:36 opera kernel: usb 1-1.2: New USB device strings: Mfr=2, Product=3, SerialNumber=1 Dec 23 05:53:36 opera kernel: usb 1-1.2: Product: EXTERNAL_USB Dec 23 05:53:36 opera kernel: usb 1-1.2: Manufacturer: TOSHIBA Dec 23 05:53:36 opera kernel: usb 1-1.2: SerialNumber: 20220116005052F Dec 23 05:53:36 opera kernel: usb-storage 1-1.2:1.0: USB Mass Storage device detected Dec 23 05:53:36 opera kernel: scsi host40: usb-storage 1-1.2:1.0 Dec 23 05:53:36 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:37 opera kernel: scsi 40:0:0:0: Direct-Access TOSHIBA EXTERNAL_USB 0 PQ: 0 ANSI: 6 Dec 23 05:53:37 opera kernel: sd 40:0:0:0: [sda] Spinning up disk... Dec 23 05:53:37 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:38 opera kernel: .ready Dec 23 05:53:38 opera kernel: sd 40:0:0:0: [sda] 1953525168 512-byte logical blocks: (1.00 TB/932 GiB) Dec 23 05:53:38 opera kernel: sd 40:0:0:0: [sda] Write Protect is off Dec 23 05:53:38 opera kernel: sd 40:0:0:0: [sda] Mode Sense: 43 00 00 00 Dec 23 05:53:38 opera kernel: sd 40:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA Dec 23 05:53:38 opera kernel: sda: sda1 Dec 23 05:53:38 opera kernel: sd 40:0:0:0: [sda] Attached SCSI disk Dec 23 05:53:38 opera udisks-glue[680]: Device file /dev/sda inserted Dec 23 05:53:38 opera udisks-glue[680]: Device file /dev/sda1 inserted Dec 23 05:53:38 opera udisks-glue[680]: Trying to automount /dev/sda1... Dec 23 05:53:38 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:39 opera ntfs-3g[2743]: Version 2014.2.15AR.2 integrated FUSE 28 Dec 23 05:53:39 opera ntfs-3g[2743]: Mounted /dev/sda1 (Read-Write, label "yy1", NTFS 3.1) Dec 23 05:53:39 opera ntfs-3g[2743]: Cmdline options: rw,nodev,nosuid,noatime,uid=1000,gid=1000,dmask=0077,fmask=0177,dmask=0000,fmask=0000,uhelper=udisks Dec 23 05:53:39 opera ntfs-3g[2743]: Mount options: rw,nodev,nosuid,uhelper=udisks,allow_other,nonempty,noatime,default_permissions,fsname=/dev/sda1,blkdev,blksize=4096 Dec 23 05:53:39 opera ntfs-3g[2743]: Global ownership and permissions enforced, configuration type 7 Dec 23 05:53:39 opera udisks-glue[680]: Successfully automounted /dev/sda1 at /media/yy1_ Dec 23 05:53:39 opera udisks-glue[680]: Device file /dev/sda1 mounted at /media/yy1_ Dec 23 05:53:39 opera udisks-glue[680]: Updating DB (#4) ... Dec 23 05:53:39 opera udisks-glue[680]: volume: n/a repeat: off random: off single: off consume: off Dec 23 05:53:39 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:40 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:41 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:42 opera systemd-journal[252]: Suppressed 160 messages from /system.slice/volumio.service Dec 23 05:53:42 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:42 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:42 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:42 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:42 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:42 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:42 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:42 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:42 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:42 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:42 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:42 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:42 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:42 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:42 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:42 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:42 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:42 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:42 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:42 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:42 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:42 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:42 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:42 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:42 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:42 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:42 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:42 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:42 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:42 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:42 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:42 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:42 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:42 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:42 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:42 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:42 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:42 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:42 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:42 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:42 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:42 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:42 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:42 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:42 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:42 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:43 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:44 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:45 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:45 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:45 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:45 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:45 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:45 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:45 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:45 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:45 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:45 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:45 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:45 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:45 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:45 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:45 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:45 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:45 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:45 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:45 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:45 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:45 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:45 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:45 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:45 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:45 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:45 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:45 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:45 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:45 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:45 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:45 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:45 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:45 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:45 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:45 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:45 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:45 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:45 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:45 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:45 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:45 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:45 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:45 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:45 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:45 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:45 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:46 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:47 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:48 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:48 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:48 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:48 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:48 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:48 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:48 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:48 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:48 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:48 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:48 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:48 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:48 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:48 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:48 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:48 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:48 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:48 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:48 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:48 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:48 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:48 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:48 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:48 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:48 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:48 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:48 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:48 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:48 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:48 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:48 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:48 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:48 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:48 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:48 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:48 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:48 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:48 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:48 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:48 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:48 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:48 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:48 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:48 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:48 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:48 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:49 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:50 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:51 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:51 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:51 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:51 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:51 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:51 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:51 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:51 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:51 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:51 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:51 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:51 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:51 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:51 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:51 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:51 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:51 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:51 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:51 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:51 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:51 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:51 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:51 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:51 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:51 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:51 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:51 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:51 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:51 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:51 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:51 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:51 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:51 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:51 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:51 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:51 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:51 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:51 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:51 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:51 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:52 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:52 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:52 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:52 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:52 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:52 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:52 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:53 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:54 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:54 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:54 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:54 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:54 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:54 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:54 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:54 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:54 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:54 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:54 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:54 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:54 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:54 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:54 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:54 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:54 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:54 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:54 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:54 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:54 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:54 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:54 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:54 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:54 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:54 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:54 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:54 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:54 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:54 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:54 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:54 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:54 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:54 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:54 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:54 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:54 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:54 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:54 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:54 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:54 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:54 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:54 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:54 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:54 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:54 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:55 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:56 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:56 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:56 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:56 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:56 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:56 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:56 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:56 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:56 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:56 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:56 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:56 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:56 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:56 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:56 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:56 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:56 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:56 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:56 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:56 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:56 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:56 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:56 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:56 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:56 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:56 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:56 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:56 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:56 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:56 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:56 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:56 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:56 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:56 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:56 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:56 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:56 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:56 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:56 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:56 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:56 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:56 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:56 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:56 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:56 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:56 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:56 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:56 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:56 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:56 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:56 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:56 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:56 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:56 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:56 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:56 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:56 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:56 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:56 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:56 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:56 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:56 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:56 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:56 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:56 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:56 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:56 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:56 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:56 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:56 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:56 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:56 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:56 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:56 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:56 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:56 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:57 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:58 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:58 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:58 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:58 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:58 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:58 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:58 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:58 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:58 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:58 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:58 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:58 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:58 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:58 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:58 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:58 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:58 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:58 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:58 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:58 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:58 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:58 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:58 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:58 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:58 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:58 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:58 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:58 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:58 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:58 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:58 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:58 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:58 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:58 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:58 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:58 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:53:58 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:53:58 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:53:58 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:53:58 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:58 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:58 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:58 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:58 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:58 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:53:58 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:53:59 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:54:00 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:00 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:00 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:00 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:00 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:00 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:00 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:00 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:00 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:00 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:00 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:00 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:00 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:00 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:00 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:00 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:00 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:00 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:00 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:00 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:00 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:00 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:00 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:00 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:00 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:00 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:00 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:00 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:00 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:00 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:00 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:00 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:00 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:00 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:00 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:00 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:00 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:00 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:00 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:00 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:00 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:00 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:00 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:00 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:00 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:00 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:54:01 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:54:02 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:02 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:02 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:02 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:02 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:02 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:02 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:02 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:02 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:02 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:02 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:02 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:02 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:02 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:02 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:02 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:02 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:02 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:02 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:02 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:02 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:02 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:02 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:02 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:02 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:02 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:02 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:02 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:02 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:02 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:02 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:02 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:02 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:02 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:02 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:02 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:02 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:02 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:02 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:02 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:02 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:02 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:02 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:02 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:02 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:02 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:54:03 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:54:04 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:04 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:04 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:04 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:04 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:04 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:04 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:04 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:04 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:04 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:04 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:04 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:04 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:04 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:04 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:04 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:04 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:04 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:04 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:04 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:04 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:04 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:04 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:04 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:04 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:04 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:04 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:04 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:04 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:04 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:04 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:04 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:04 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:04 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:04 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:04 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:04 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:04 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:04 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:04 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:04 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:04 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:04 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:04 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:04 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:04 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:54:05 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:54:06 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:54:07 opera volumio[1181]: info: MPD Database updated - AlbumList cache refreshed Dec 23 05:54:07 opera volumio[1181]: info: Dec 23 05:54:07 opera volumio[1181]: ---------------------------- MPD announces state update: database Dec 23 05:54:07 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Dec 23 05:54:07 opera volumio[1181]: info: Dec 23 05:54:07 opera volumio[1181]: ---------------------------- MPD announces state update: update Dec 23 05:54:07 opera volumio[1181]: info: ControllerMpd::getState Dec 23 05:54:07 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Dec 23 05:54:07 opera volumio[1181]: info: ControllerMpd::getState Dec 23 05:54:07 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Dec 23 05:54:07 opera volumio[1181]: info: sendMpdCommand status took 109 milliseconds Dec 23 05:54:07 opera volumio[1181]: info: sendMpdCommand status took 109 milliseconds Dec 23 05:54:07 opera volumio[1181]: info: sendMpdCommand status took 108 milliseconds Dec 23 05:54:07 opera volumio[1181]: verbose: ControllerMpd::parseState Dec 23 05:54:07 opera volumio[1181]: info: Command Router : Notfying DB Updatetrue Dec 23 05:54:07 opera volumio[1181]: info: CoreCommandRouter::Close All Modals sent Dec 23 05:54:07 opera volumio[1181]: verbose: ControllerMpd::parseState Dec 23 05:54:07 opera volumio[1181]: verbose: ControllerMpd::parseState Dec 23 05:54:07 opera volumio[1181]: info: ControllerMpd::pushState Dec 23 05:54:07 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:07 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:07 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:07 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:07 opera volumio[1181]: info: CorePlayQueue::getTrack 489 Dec 23 05:54:07 opera volumio[1181]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 23 05:54:07 opera volumio[1181]: verbose: CURRENT POSITION 489 Dec 23 05:54:07 opera volumio[1181]: info: CoreStateMachine::syncState stateService stop Dec 23 05:54:07 opera volumio[1181]: info: CoreStateMachine::syncState currentStatus play Dec 23 05:54:07 opera volumio[1181]: info: CoreStateMachine::play index undefined Dec 23 05:54:07 opera volumio[1181]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 23 05:54:07 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:07 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:07 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:07 opera volumio[1181]: info: ControllerMpd::pushState Dec 23 05:54:07 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:07 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:07 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:07 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:07 opera volumio[1181]: info: CorePlayQueue::getTrack 548 Dec 23 05:54:07 opera volumio[1181]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 23 05:54:07 opera volumio[1181]: verbose: CURRENT POSITION 548 Dec 23 05:54:07 opera volumio[1181]: info: CoreStateMachine::syncState stateService stop Dec 23 05:54:07 opera volumio[1181]: info: CoreStateMachine::syncState currentStatus stop Dec 23 05:54:07 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:07 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:07 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:07 opera volumio[1181]: info: No code Dec 23 05:54:07 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:07 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:07 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:07 opera volumio[1181]: info: CorePlayQueue::getTrack 548 Dec 23 05:54:07 opera volumio[1181]: info: CoreStateMachine::startPlaybackTimer Dec 23 05:54:07 opera volumio[1181]: info: CorePlayQueue::getTrack 548 Dec 23 05:54:07 opera volumio[1181]: verbose: ControllerMpd::clearAddPlayTracks USB/yy1_/DSD/回憶錄：五輪真弓/03 - Mayumi Itsuwa - 潮騷Shiosai (Album Version).dsf Dec 23 05:54:07 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand stop Dec 23 05:54:07 opera volumio[1181]: info: ------------------------------ 162ms Dec 23 05:54:07 opera volumio[1181]: info: ------------------------------ 162ms Dec 23 05:54:07 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:07 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:07 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:07 opera volumio[1181]: info: sendMpdCommand stop took 11 milliseconds Dec 23 05:54:07 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand clear Dec 23 05:54:07 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:07 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:07 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:07 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:07 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:07 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:07 opera volumio[1181]: info: Dec 23 05:54:07 opera volumio[1181]: ---------------------------- MPD announces system playlist update Dec 23 05:54:07 opera volumio[1181]: info: Ignoring MPD Status Update Dec 23 05:54:07 opera volumio[1181]: info: sendMpdCommand clear took 17 milliseconds Dec 23 05:54:07 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand add "USB/yy1_/DSD/回憶錄：五輪真弓/03 - Mayumi Itsuwa - 潮騷Shiosai (Album Version).dsf" Dec 23 05:54:07 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:07 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:07 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:07 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:07 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:07 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:07 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:07 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:07 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:07 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:07 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:07 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:07 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:07 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:07 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:07 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:07 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:07 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:07 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:07 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:07 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:07 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:07 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:07 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:07 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:07 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:07 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:07 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:07 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:07 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:07 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:07 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:07 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:07 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:07 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:07 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:07 opera volumio[1181]: error: updateQueue error: null Dec 23 05:54:07 opera volumio[1181]: info: Dec 23 05:54:07 opera volumio[1181]: ---------------------------- MPD announces system playlist update Dec 23 05:54:07 opera volumio[1181]: info: Ignoring MPD Status Update Dec 23 05:54:07 opera volumio[1181]: info: ------------------------------ 42ms Dec 23 05:54:07 opera volumio[1181]: info: sendMpdCommand add "USB/yy1_/DSD/回憶錄：五輪真弓/03 - Mayumi Itsuwa - 潮騷Shiosai (Album Version).dsf" took 41 milliseconds Dec 23 05:54:07 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand play Dec 23 05:54:07 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:07 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:07 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:07 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:07 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:07 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:07 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:07 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:07 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:07 opera volumio[1181]: info: ------------------------------ 25ms Dec 23 05:54:07 opera volumio[1181]: info: sendMpdCommand play took 23 milliseconds Dec 23 05:54:07 opera volumio[1181]: info: Dec 23 05:54:07 opera volumio[1181]: ---------------------------- MPD announces state update: player Dec 23 05:54:07 opera volumio[1181]: info: ControllerMpd::getState Dec 23 05:54:07 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Dec 23 05:54:07 opera volumio[1181]: info: Dec 23 05:54:07 opera volumio[1181]: ---------------------------- MPD announces state update: player Dec 23 05:54:07 opera volumio[1181]: info: ControllerMpd::getState Dec 23 05:54:07 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Dec 23 05:54:07 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand clearerror Dec 23 05:54:07 opera volumio[1181]: info: sendMpdCommand status took 6 milliseconds Dec 23 05:54:07 opera volumio[1181]: verbose: ControllerMpd::parseState Dec 23 05:54:07 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 05:54:07 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand clearerror Dec 23 05:54:07 opera volumio[1181]: info: sendMpdCommand status took 9 milliseconds Dec 23 05:54:07 opera volumio[1181]: info: sendMpdCommand clearerror took 5 milliseconds Dec 23 05:54:07 opera volumio[1181]: info: sendMpdCommand playlistinfo took 5 milliseconds Dec 23 05:54:07 opera volumio[1181]: verbose: ControllerMpd::parseState Dec 23 05:54:07 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 05:54:07 opera volumio[1181]: verbose: ControllerMpd::parseTrackInfo Dec 23 05:54:07 opera volumio[1181]: info: ControllerMpd::pushState Dec 23 05:54:07 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:07 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:07 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:07 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:07 opera volumio[1181]: info: ------------------------------ 32ms Dec 23 05:54:07 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:07 opera volumio[1181]: info: sendMpdCommand clearerror took 18 milliseconds Dec 23 05:54:07 opera volumio[1181]: info: sendMpdCommand playlistinfo took 15 milliseconds Dec 23 05:54:07 opera volumio[1181]: verbose: ControllerMpd::parseTrackInfo Dec 23 05:54:07 opera volumio[1181]: info: ControllerMpd::pushState Dec 23 05:54:07 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:07 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:07 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:07 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:07 opera volumio[1181]: info: ------------------------------ 34ms Dec 23 05:54:07 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:07 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:54:08 opera kernel: usb 1-1.2: USB disconnect, device number 53 Dec 23 05:54:08 opera ntfs-3g[2743]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Dec 23 05:54:08 opera ntfs-3g[2743]: Failed to read vcn 0x1: Input/output error Dec 23 05:54:08 opera ntfs-3g[2743]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Dec 23 05:54:08 opera ntfs-3g[2743]: Failed to read vcn 0x6: Input/output error Dec 23 05:54:08 opera ntfs-3g[2743]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Dec 23 05:54:08 opera ntfs-3g[2743]: Failed to read vcn 0x6: Input/output error Dec 23 05:54:08 opera ntfs-3g[2743]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Dec 23 05:54:08 opera ntfs-3g[2743]: Failed to read vcn 0x6: Input/output error Dec 23 05:54:08 opera ntfs-3g[2743]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Dec 23 05:54:08 opera ntfs-3g[2743]: Failed to read vcn 0x6: Input/output error Dec 23 05:54:08 opera ntfs-3g[2743]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Dec 23 05:54:08 opera ntfs-3g[2743]: Failed to read vcn 0x6: Input/output error Dec 23 05:54:08 opera ntfs-3g[2743]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Dec 23 05:54:08 opera ntfs-3g[2743]: Failed to read vcn 0x6: Input/output error Dec 23 05:54:08 opera ntfs-3g[2743]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Dec 23 05:54:08 opera ntfs-3g[2743]: Failed to read vcn 0x6: Input/output error Dec 23 05:54:08 opera ntfs-3g[2743]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Dec 23 05:54:08 opera ntfs-3g[2743]: Failed to read vcn 0x6: Input/output error Dec 23 05:54:08 opera ntfs-3g[2743]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Dec 23 05:54:08 opera ntfs-3g[2743]: Failed to read vcn 0x6: Input/output error Dec 23 05:54:08 opera ntfs-3g[2743]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Dec 23 05:54:08 opera ntfs-3g[2743]: Failed to read vcn 0x6: Input/output error Dec 23 05:54:08 opera ntfs-3g[2743]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Dec 23 05:54:08 opera ntfs-3g[2743]: Failed to read vcn 0x6: Input/output error Dec 23 05:54:08 opera ntfs-3g[2743]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Dec 23 05:54:08 opera ntfs-3g[2743]: Failed to read vcn 0x6: Input/output error Dec 23 05:54:08 opera ntfs-3g[2743]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Dec 23 05:54:08 opera ntfs-3g[2743]: Failed to read vcn 0x6: Input/output error Dec 23 05:54:08 opera ntfs-3g[2743]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Dec 23 05:54:08 opera ntfs-3g[2743]: Failed to read vcn 0x6: Input/output error Dec 23 05:54:08 opera ntfs-3g[2743]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Dec 23 05:54:08 opera ntfs-3g[2743]: Failed to read vcn 0x6: Input/output error Dec 23 05:54:08 opera ntfs-3g[2743]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Dec 23 05:54:08 opera ntfs-3g[2743]: Failed to read vcn 0x6: Input/output error Dec 23 05:54:08 opera ntfs-3g[2743]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Dec 23 05:54:08 opera ntfs-3g[2743]: Failed to read vcn 0x6: Input/output error Dec 23 05:54:08 opera ntfs-3g[2743]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Dec 23 05:54:08 opera ntfs-3g[2743]: Failed to read vcn 0x6: Input/output error Dec 23 05:54:08 opera kernel: sd 40:0:0:0: [sda] Synchronizing SCSI cache Dec 23 05:54:08 opera kernel: sd 40:0:0:0: [sda] Synchronize Cache(10) failed: Result: hostbyte=0x01 driverbyte=0x00 Dec 23 05:54:08 opera udisks-glue[680]: Device file /dev/sda1 unmounted from /media/yy1_ Dec 23 05:54:08 opera udisks-glue[680]: Device file /dev/sda1 removed Dec 23 05:54:08 opera udisks-glue[680]: Device file /dev/sda removed Dec 23 05:54:08 opera udisks-glue[680]: Mayumi Itsuwa - Shiosai (Album Version) Dec 23 05:54:08 opera udisks-glue[680]: [paused] #1/1 0:00/3:38 (0%) Dec 23 05:54:08 opera udisks-glue[680]: Updating DB (#5) ... Dec 23 05:54:08 opera udisks-glue[680]: volume: n/a repeat: off random: off single: off consume: off Dec 23 05:54:08 opera udisks-glue[680]: Mayumi Itsuwa - Shiosai (Album Version) Dec 23 05:54:08 opera udisks-glue[680]: [paused] #1/1 0:00/3:38 (0%) Dec 23 05:54:08 opera udisks-glue[680]: Updating DB (#5) ... Dec 23 05:54:08 opera udisks-glue[680]: volume: n/a repeat: off random: off single: off consume: off Dec 23 05:54:08 opera volumio[1181]: info: MPD Database updated - AlbumList cache refreshed Dec 23 05:54:08 opera volumio[1181]: info: Dec 23 05:54:08 opera volumio[1181]: ---------------------------- MPD announces state update: database Dec 23 05:54:08 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Dec 23 05:54:08 opera volumio[1181]: info: Dec 23 05:54:08 opera volumio[1181]: ---------------------------- MPD announces state update: update Dec 23 05:54:08 opera volumio[1181]: info: ControllerMpd::getState Dec 23 05:54:08 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Dec 23 05:54:08 opera volumio[1181]: info: ControllerMpd::getState Dec 23 05:54:08 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Dec 23 05:54:08 opera volumio[1181]: info: MPD Database updated - AlbumList cache refreshed Dec 23 05:54:08 opera volumio[1181]: info: Dec 23 05:54:08 opera volumio[1181]: ---------------------------- MPD announces state update: database Dec 23 05:54:08 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Dec 23 05:54:08 opera volumio[1181]: info: Dec 23 05:54:08 opera volumio[1181]: ---------------------------- MPD announces state update: update Dec 23 05:54:08 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Dec 23 05:54:08 opera volumio[1181]: info: Dec 23 05:54:08 opera volumio[1181]: ---------------------------- MPD announces state update: update Dec 23 05:54:08 opera volumio[1181]: info: ControllerMpd::getState Dec 23 05:54:08 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Dec 23 05:54:08 opera volumio[1181]: info: ControllerMpd::getState Dec 23 05:54:08 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Dec 23 05:54:08 opera volumio[1181]: info: sendMpdCommand status took 34 milliseconds Dec 23 05:54:08 opera volumio[1181]: info: sendMpdCommand status took 33 milliseconds Dec 23 05:54:08 opera volumio[1181]: info: sendMpdCommand status took 26 milliseconds Dec 23 05:54:08 opera volumio[1181]: info: ControllerMpd::getState Dec 23 05:54:08 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Dec 23 05:54:08 opera volumio[1181]: verbose: ControllerMpd::parseState Dec 23 05:54:08 opera volumio[1181]: info: Command Router : Notfying DB Updatetrue Dec 23 05:54:08 opera volumio[1181]: info: CoreCommandRouter::Close All Modals sent Dec 23 05:54:08 opera volumio[1181]: verbose: ControllerMpd::parseState Dec 23 05:54:08 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 05:54:08 opera volumio[1181]: verbose: ControllerMpd::parseState Dec 23 05:54:08 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 05:54:08 opera volumio[1181]: info: sendMpdCommand status took 72 milliseconds Dec 23 05:54:08 opera volumio[1181]: info: sendMpdCommand status took 60 milliseconds Dec 23 05:54:08 opera volumio[1181]: info: sendMpdCommand status took 60 milliseconds Dec 23 05:54:08 opera volumio[1181]: info: sendMpdCommand status took 59 milliseconds Dec 23 05:54:08 opera volumio[1181]: info: sendMpdCommand status took 58 milliseconds Dec 23 05:54:08 opera volumio[1181]: info: sendMpdCommand playlistinfo took 8 milliseconds Dec 23 05:54:08 opera volumio[1181]: info: sendMpdCommand playlistinfo took 8 milliseconds Dec 23 05:54:08 opera volumio[1181]: verbose: ControllerMpd::parseState Dec 23 05:54:08 opera volumio[1181]: info: Command Router : Notfying DB Updatefalse Dec 23 05:54:08 opera volumio[1181]: info: CoreCommandRouter::Close All Modals sent Dec 23 05:54:08 opera volumio[1181]: verbose: ControllerMpd::parseState Dec 23 05:54:08 opera volumio[1181]: info: Command Router : Notfying DB Updatefalse Dec 23 05:54:08 opera volumio[1181]: info: CoreCommandRouter::Close All Modals sent Dec 23 05:54:08 opera volumio[1181]: verbose: ControllerMpd::parseState Dec 23 05:54:08 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 05:54:08 opera volumio[1181]: verbose: ControllerMpd::parseState Dec 23 05:54:08 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 05:54:08 opera volumio[1181]: verbose: ControllerMpd::parseState Dec 23 05:54:08 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 05:54:08 opera volumio[1181]: verbose: ControllerMpd::parseTrackInfo Dec 23 05:54:08 opera volumio[1181]: verbose: ControllerMpd::parseTrackInfo Dec 23 05:54:08 opera volumio[1181]: info: ControllerMpd::pushState Dec 23 05:54:08 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:08 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:08 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:08 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:08 opera volumio[1181]: info: ControllerMpd::pushState Dec 23 05:54:08 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:08 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:08 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:08 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:08 opera volumio[1181]: info: ------------------------------ 179ms Dec 23 05:54:08 opera volumio[1181]: info: ------------------------------ 179ms Dec 23 05:54:08 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:08 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:08 opera volumio[1181]: info: sendMpdCommand playlistinfo took 37 milliseconds Dec 23 05:54:08 opera volumio[1181]: info: sendMpdCommand playlistinfo took 39 milliseconds Dec 23 05:54:08 opera volumio[1181]: info: sendMpdCommand playlistinfo took 39 milliseconds Dec 23 05:54:08 opera volumio[1181]: verbose: ControllerMpd::parseTrackInfo Dec 23 05:54:08 opera volumio[1181]: verbose: ControllerMpd::parseTrackInfo Dec 23 05:54:08 opera volumio[1181]: verbose: ControllerMpd::parseTrackInfo Dec 23 05:54:08 opera volumio[1181]: info: ControllerMpd::pushState Dec 23 05:54:08 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:08 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:08 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:08 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:08 opera volumio[1181]: info: ControllerMpd::pushState Dec 23 05:54:08 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:08 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:08 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:08 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:08 opera volumio[1181]: info: ControllerMpd::pushState Dec 23 05:54:08 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:08 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:08 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:08 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:08 opera volumio[1181]: info: ------------------------------ 198ms Dec 23 05:54:08 opera volumio[1181]: info: ------------------------------ 198ms Dec 23 05:54:08 opera volumio[1181]: info: ------------------------------ 185ms Dec 23 05:54:08 opera kernel: rtk_btcoex: count_pan_packet_timeout: pan_packet_count 0 Dec 23 05:54:08 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:08 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:08 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:09 opera kernel: rtk_btcoex: l2cap op 6, len 16, out 0 Dec 23 05:54:09 opera kernel: rtk_btcoex: RX l2cap disconn req, hndl 0x0001, dcid 0x0040, scid 0x3a09 Dec 23 05:54:09 opera kernel: rtk_btcoex: handle_l2cap_discon_req: handle 0x0001, dcid 0x0040, scid 0x3a09, dir 0 Dec 23 05:54:09 opera kernel: rtk_btcoex: update_profile_connection: is_add 0, profile_index 3 Dec 23 05:54:09 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[3] = 0 Dec 23 05:54:09 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_bitmap 0x00 Dec 23 05:54:09 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[0] = 0 Dec 23 05:54:09 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[1] = 0 Dec 23 05:54:09 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[2] = 0 Dec 23 05:54:09 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[3] = 0 Dec 23 05:54:09 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[4] = 0 Dec 23 05:54:09 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[5] = 0 Dec 23 05:54:09 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[6] = 0 Dec 23 05:54:09 opera kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[7] = 0 Dec 23 05:54:09 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: BufferSize 2 Dec 23 05:54:09 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: NumberOfHandles 0 Dec 23 05:54:09 opera kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: profile_status 0x00 Dec 23 05:54:09 opera kernel: rtk_btcoex: rtk_vendor_cmd_to_fw: opcode 0xfc19 Dec 23 05:54:09 opera kernel: rtk_btcoex: Delete profile: hndl 0x0001, psm 0x001f, dcid 0x3a09, scid 0x0040 Dec 23 05:54:09 opera kernel: usb 1-1.2: new high-speed USB device number 54 using dwc2 Dec 23 05:54:09 opera kernel: usb 1-1.2: New USB device found, idVendor=0480, idProduct=0826 Dec 23 05:54:09 opera kernel: usb 1-1.2: New USB device strings: Mfr=2, Product=3, SerialNumber=1 Dec 23 05:54:09 opera kernel: usb 1-1.2: Product: EXTERNAL_USB Dec 23 05:54:09 opera kernel: usb 1-1.2: Manufacturer: TOSHIBA Dec 23 05:54:09 opera kernel: usb 1-1.2: SerialNumber: 20220116005052F Dec 23 05:54:09 opera kernel: usb-storage 1-1.2:1.0: USB Mass Storage device detected Dec 23 05:54:09 opera kernel: scsi host41: usb-storage 1-1.2:1.0 Dec 23 05:54:09 opera kernel: rtk_btcoex: update_hid_active_state: handle 0x0001, interval 0 Dec 23 05:54:09 opera kernel: rtk_btcoex: HID not connected, nothing to be down Dec 23 05:54:10 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:10 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:10 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:10 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:10 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:10 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:10 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:10 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:10 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:10 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:10 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:10 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:10 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:10 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:10 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:10 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:10 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:10 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:10 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:10 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:10 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:10 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:10 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:10 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:10 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:10 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:10 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:10 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:10 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:10 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:10 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:10 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:10 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:10 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:10 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:10 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:10 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:10 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:10 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:10 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:10 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:10 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:10 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:10 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:10 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:10 opera kernel: rtk_btcoex: process disconn complete event. Dec 23 05:54:10 opera kernel: scsi 41:0:0:0: Direct-Access TOSHIBA EXTERNAL_USB 0 PQ: 0 ANSI: 6 Dec 23 05:54:10 opera kernel: sd 41:0:0:0: [sdb] Spinning up disk... Dec 23 05:54:11 opera kernel: .ready Dec 23 05:54:11 opera kernel: sd 41:0:0:0: [sdb] 1953525168 512-byte logical blocks: (1.00 TB/932 GiB) Dec 23 05:54:11 opera kernel: sd 41:0:0:0: [sdb] Write Protect is off Dec 23 05:54:11 opera kernel: sd 41:0:0:0: [sdb] Mode Sense: 43 00 00 00 Dec 23 05:54:11 opera kernel: sd 41:0:0:0: [sdb] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA Dec 23 05:54:11 opera kernel: sdb: sdb1 Dec 23 05:54:11 opera kernel: sd 41:0:0:0: [sdb] Attached SCSI disk Dec 23 05:54:12 opera udisks-glue[680]: Device file /dev/sdb inserted Dec 23 05:54:12 opera udisks-glue[680]: Device file /dev/sdb1 inserted Dec 23 05:54:12 opera udisks-glue[680]: Trying to automount /dev/sdb1... Dec 23 05:54:13 opera ntfs-3g[2810]: Version 2014.2.15AR.2 integrated FUSE 28 Dec 23 05:54:13 opera ntfs-3g[2810]: Mounted /dev/sdb1 (Read-Write, label "yy1", NTFS 3.1) Dec 23 05:54:13 opera ntfs-3g[2810]: Cmdline options: rw,nodev,nosuid,noatime,uid=1000,gid=1000,dmask=0077,fmask=0177,dmask=0000,fmask=0000,uhelper=udisks Dec 23 05:54:13 opera ntfs-3g[2810]: Mount options: rw,nodev,nosuid,uhelper=udisks,allow_other,nonempty,noatime,default_permissions,fsname=/dev/sdb1,blkdev,blksize=4096 Dec 23 05:54:13 opera ntfs-3g[2810]: Global ownership and permissions enforced, configuration type 7 Dec 23 05:54:13 opera udisks-glue[680]: Successfully automounted /dev/sdb1 at /media/yy1_ Dec 23 05:54:13 opera udisks-glue[680]: Device file /dev/sdb1 mounted at /media/yy1_ Dec 23 05:54:13 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Dec 23 05:54:13 opera volumio[1181]: info: Dec 23 05:54:13 opera volumio[1181]: ---------------------------- MPD announces state update: update Dec 23 05:54:13 opera volumio[1181]: info: ControllerMpd::getState Dec 23 05:54:13 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Dec 23 05:54:13 opera volumio[1181]: info: sendMpdCommand status took 2 milliseconds Dec 23 05:54:13 opera volumio[1181]: info: sendMpdCommand status took 2 milliseconds Dec 23 05:54:13 opera volumio[1181]: verbose: ControllerMpd::parseState Dec 23 05:54:13 opera udisks-glue[680]: Mayumi Itsuwa - Shiosai (Album Version) Dec 23 05:54:13 opera udisks-glue[680]: [paused] #1/1 0:00/3:38 (0%) Dec 23 05:54:13 opera udisks-glue[680]: Updating DB (#8) ... Dec 23 05:54:13 opera udisks-glue[680]: volume: n/a repeat: off random: off single: off consume: off Dec 23 05:54:13 opera volumio[1181]: info: Command Router : Notfying DB Updatetrue Dec 23 05:54:13 opera volumio[1181]: info: CoreCommandRouter::Close All Modals sent Dec 23 05:54:13 opera volumio[1181]: verbose: ControllerMpd::parseState Dec 23 05:54:13 opera volumio[1181]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 05:54:13 opera volumio[1181]: info: sendMpdCommand playlistinfo took 3 milliseconds Dec 23 05:54:13 opera volumio[1181]: verbose: ControllerMpd::parseTrackInfo Dec 23 05:54:13 opera volumio[1181]: info: ControllerMpd::pushState Dec 23 05:54:13 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:13 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:13 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:13 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:13 opera volumio[1181]: info: ------------------------------ 53ms Dec 23 05:54:13 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:13 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:13 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:13 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:13 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:13 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:13 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:13 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:13 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:13 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:13 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:13 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:13 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:13 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:13 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:13 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:13 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:13 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:13 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:13 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:13 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:13 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:13 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:13 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:13 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:13 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:13 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:13 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:13 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:13 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:13 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:13 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:13 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:13 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:13 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:13 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:13 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:13 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:13 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:13 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:13 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:13 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:13 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:13 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:13 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:13 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:17 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:17 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:17 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:17 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:17 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:17 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:17 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:17 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:17 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:17 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:17 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:17 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:17 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:17 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:17 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:17 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:17 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:17 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:17 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:17 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:17 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:17 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:17 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:17 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:17 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:17 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:17 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:17 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:17 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:17 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:17 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:17 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:17 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:17 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:17 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:17 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:17 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:17 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:17 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:17 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:17 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:17 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:17 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:17 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:17 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:21 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:21 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:21 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:21 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:21 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:21 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:21 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:21 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:21 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:21 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:21 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:21 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:21 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:21 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:21 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:21 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:21 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:21 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:21 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:21 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:21 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:21 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:21 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:21 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:21 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:21 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:21 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:21 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:21 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:21 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:21 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:21 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:21 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:21 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:21 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:21 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:21 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:21 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:21 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:21 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:21 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:21 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:21 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:21 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:21 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:24 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:24 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:24 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:24 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:24 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:24 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:24 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:24 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:24 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:24 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:24 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:24 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:24 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:24 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:24 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:24 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:24 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:24 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:24 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:24 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:24 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:24 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:24 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:24 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:24 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:24 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:24 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:24 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:24 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:24 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:24 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:24 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:24 opera volumio[1181]: info: CoreCommandRouter::servicePushState Dec 23 05:54:24 opera volumio[1181]: info: CoreStateMachine::pushState Dec 23 05:54:24 opera volumio[1181]: info: CoreCommandRouter::volumioPushState Dec 23 05:54:24 opera volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 05:54:24 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:24 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:24 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:24 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:24 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:24 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:24 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:24 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:24 opera volumio[1181]: info: Updating RAAT Signal Path Dec 23 05:54:25 opera volumio[1181]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 23 05:54:25 opera volumio[1181]: { Error: connect ETIMEDOUT 69.197.153.180:443 Dec 23 05:54:25 opera volumio[1181]: at Object._errnoException (util.js:1022:11) Dec 23 05:54:25 opera volumio[1181]: at _exceptionWithHostPort (util.js:1044:20) Dec 23 05:54:25 opera volumio[1181]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Dec 23 05:54:25 opera volumio[1181]: code: 'ETIMEDOUT', Dec 23 05:54:25 opera volumio[1181]: errno: 'ETIMEDOUT', Dec 23 05:54:25 opera volumio[1181]: syscall: 'connect', Dec 23 05:54:25 opera volumio[1181]: address: '69.197.153.180', Dec 23 05:54:25 opera volumio[1181]: port: 443 } Dec 23 05:54:25 opera volumio[1181]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 23 05:54:25 opera sudo[2868]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-23 05:53 Dec 23 05:54:25 opera sudo[2868]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 8 (jessie)" NAME="Debian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=debian HOME_URL="http://www.debian.org/" SUPPORT_URL="http://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="047a38c6e11e7058b10d3038ac9dcbff94f92828" VOLUMIO_BE_VERSION="3e944f35d34b575025d16b976b4cb4d9aed53b66" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="opera" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Apr 8 17:29:57 CEST 2022" VOLUMIO_VERSION="1.033" VOLUMIO_HARDWARE="tinkerboard" VOLUMIO_VENDOR="Opera Consonance" VOLUMIO_MODEL="X5" VOLUMIO_VENDOR_MODEL="Opera X5" VOLUMIO_HASH="77fa3b0bf86939c934741dd9bb62adcc"