-- Logs begin at Thu 2019-02-14 18:11:58 CST, end at Wed 2024-11-27 19:54:33 CST. -- Nov 27 19:53:04 volumio kernel: usb 2-1: USB disconnect, device number 2 Nov 27 19:53:04 volumio volumio[1166]: info: Partition removed: {"syspath":"/sys/devices/platform/axi/1000120000.pcie/1f00200000.usb/xhci-hcd.0/usb2/2-1/2-1:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","ACTION":"remove","DEVLINKS":"/dev/disk/by-uuid/40B6F4A2B6F4999C /dev/disk/by-path/platform-xhci-hcd.0-usb-0:1:1.0-scsi-0:0:0:0-part1 /dev/disk/by-partuuid/7fd17fd1-01 /dev/disk/by-label/新加卷 /dev/disk/by-id/usb-ST950042_0AS_000000123ACD-0:0-part1","DEVNAME":"/dev/sda1","DEVPATH":"/devices/platform/axi/1000120000.pcie/1f00200000.usb/xhci-hcd.0/usb2/2-1/2-1:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","DEVTYPE":"partition","DISKSEQ":"26","ID_BUS":"usb","ID_FS_LABEL":"新加卷","ID_FS_LABEL_ENC":"新加卷","ID_FS_TYPE":"ntfs","ID_FS_USAGE":"filesystem","ID_FS_UUID":"40B6F4A2B6F4999C","ID_FS_UUID_ENC":"40B6F4A2B6F4999C","ID_INSTANCE":"0:0","ID_MODEL":"0AS","ID_MODEL_ENC":"0AS\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20","ID_MODEL_ID":"0711","ID_PART_ENTRY_DISK":"8:0","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"2048","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"976766976","ID_PART_ENTRY_TYPE":"0x7","ID_PART_ENTRY_UUID":"7fd17fd1-01","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"7fd17fd1","ID_PATH":"platform-xhci-hcd.0-usb-0:1:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-xhci-hcd_0-usb-0_1_1_0-scsi-0_0_0_0","ID_REVISION":"0006","ID_SERIAL":"ST950042_0AS_000000123ACD-0:0","ID_SERIAL_SHORT":"000000123ACD","ID_TYPE":"disk","ID_USB_DRIVER":"usb-storage","ID_USB_INTERFACES":":080650:","ID_USB_INTERFACE_NUM":"00","ID_VENDOR":"ST950042","ID_VENDOR_ENC":"ST950042","ID_VENDOR_ID":"2109","MAJOR":"8","MINOR":"1","PARTN":"1","SEQNUM":"3089","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"2840020"} Nov 27 19:53:04 volumio sudo[2064]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sda1 Nov 27 19:53:04 volumio sudo[2064]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 27 19:53:04 volumio ntfs-3g[1239]: Unmounting /dev/sda1 (新加卷) Nov 27 19:53:04 volumio ntfs-3g[1239]: Failed to sync device /dev/sda1: Input/output error Nov 27 19:53:04 volumio ntfs-3g[1239]: Failed to close volume /dev/sda1: Input/output error Nov 27 19:53:04 volumio sudo[2064]: pam_unix(sudo:session): session closed for user root Nov 27 19:53:04 volumio systemd[1]: media-\xe6\x96\xb0\xe5\x8a\xa0\xe5\x8d\xb7.mount: Succeeded. Nov 27 19:53:04 volumio kernel: sd 0:0:0:0: [sda] Synchronizing SCSI cache Nov 27 19:53:04 volumio kernel: sd 0:0:0:0: [sda] Synchronize Cache(10) failed: Result: hostbyte=0x01 driverbyte=DRIVER_OK Nov 27 19:53:06 volumio volumio-remote-updater[792]: No test mode Nov 27 19:53:06 volumio volumio-remote-updater[792]: No alpha test mode Nov 27 19:53:06 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Nov 27 19:53:06 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Nov 27 19:53:06 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Nov 27 19:53:06 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Nov 27 19:53:06 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Nov 27 19:53:07 volumio volumio[1166]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Nov 27 19:53:07 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Nov 27 19:53:07 volumio kernel: usb 2-1: new SuperSpeed USB device number 3 using xhci-hcd Nov 27 19:53:07 volumio kernel: usb 2-1: New USB device found, idVendor=2109, idProduct=0711, bcdDevice= 1.44 Nov 27 19:53:07 volumio kernel: usb 2-1: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Nov 27 19:53:07 volumio kernel: usb 2-1: Product: VLI Product String Nov 27 19:53:07 volumio kernel: usb 2-1: Manufacturer: VLI manufacture String Nov 27 19:53:07 volumio kernel: usb 2-1: SerialNumber: 000000123ACD Nov 27 19:53:07 volumio kernel: usb-storage 2-1:1.0: USB Mass Storage device detected Nov 27 19:53:07 volumio kernel: usb-storage 2-1:1.0: Quirks match for vid 2109 pid 0711: 2000000 Nov 27 19:53:07 volumio kernel: scsi host0: usb-storage 2-1:1.0 Nov 27 19:53:08 volumio volumio[1166]: info: TEST: Here we shall have deleted mounted folder: /mnt/USB/新加卷 Nov 27 19:53:09 volumio volumio[1166]: info: Scanning removed location : "USB/新加卷" Nov 27 19:53:09 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand status Nov 27 19:53:09 volumio volumio[1166]: info: Nov 27 19:53:09 volumio volumio[1166]: ---------------------------- MPD announces state update: update Nov 27 19:53:09 volumio volumio[1166]: info: ControllerMpd::getState Nov 27 19:53:09 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand status Nov 27 19:53:09 volumio volumio[1166]: info: sendMpdCommand status took 1 milliseconds Nov 27 19:53:09 volumio volumio[1166]: info: sendMpdCommand status took 1 milliseconds Nov 27 19:53:09 volumio volumio[1166]: verbose: ControllerMpd::parseState Nov 27 19:53:09 volumio volumio[1166]: info: Command Router : Notfying DB Updatetrue Nov 27 19:53:09 volumio volumio[1166]: verbose: ControllerMpd::parseState Nov 27 19:53:09 volumio volumio[1166]: info: ControllerMpd::pushState Nov 27 19:53:09 volumio volumio[1166]: info: CoreCommandRouter::servicePushState Nov 27 19:53:09 volumio volumio[1166]: info: CoreStateMachine::pushState Nov 27 19:53:09 volumio volumio[1166]: info: CorePlayQueue::getTrack 11 Nov 27 19:53:09 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 27 19:53:09 volumio volumio[1166]: info: CoreCommandRouter::volumioPushState Nov 27 19:53:09 volumio volumio[1166]: info: CorePlayQueue::getTrack 11 Nov 27 19:53:09 volumio volumio[1166]: 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} Nov 27 19:53:09 volumio volumio[1166]: verbose: CURRENT POSITION 11 Nov 27 19:53:09 volumio volumio[1166]: info: CoreStateMachine::syncState stateService stop Nov 27 19:53:09 volumio volumio[1166]: info: CoreStateMachine::syncState currentStatus stop Nov 27 19:53:09 volumio volumio[1166]: info: CoreStateMachine::pushState Nov 27 19:53:09 volumio volumio[1166]: info: CorePlayQueue::getTrack 11 Nov 27 19:53:09 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 27 19:53:09 volumio volumio[1166]: info: CoreCommandRouter::volumioPushState Nov 27 19:53:09 volumio volumio[1166]: info: No code Nov 27 19:53:09 volumio volumio[1166]: info: CoreStateMachine::pushState Nov 27 19:53:09 volumio volumio[1166]: info: CorePlayQueue::getTrack 11 Nov 27 19:53:09 volumio volumio[1166]: info: CoreCommandRouter::volumioPushState Nov 27 19:53:09 volumio volumio[1166]: info: ------------------------------ 148ms Nov 27 19:53:09 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand status Nov 27 19:53:09 volumio volumio[1166]: info: Nov 27 19:53:09 volumio volumio[1166]: ---------------------------- MPD announces state update: update Nov 27 19:53:09 volumio volumio[1166]: info: ControllerMpd::getState Nov 27 19:53:09 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand status Nov 27 19:53:09 volumio volumio[1166]: info: sendMpdCommand status took 6 milliseconds Nov 27 19:53:09 volumio volumio[1166]: info: sendMpdCommand status took 6 milliseconds Nov 27 19:53:09 volumio volumio[1166]: verbose: ControllerMpd::parseState Nov 27 19:53:09 volumio volumio[1166]: info: Command Router : Notfying DB Updatefalse Nov 27 19:53:09 volumio volumio[1166]: info: CoreCommandRouter::Close All Modals sent Nov 27 19:53:09 volumio volumio[1166]: verbose: ControllerMpd::parseState Nov 27 19:53:09 volumio volumio[1166]: info: ControllerMpd::pushState Nov 27 19:53:09 volumio volumio[1166]: info: CoreCommandRouter::servicePushState Nov 27 19:53:09 volumio volumio[1166]: info: CoreStateMachine::pushState Nov 27 19:53:09 volumio volumio[1166]: info: CorePlayQueue::getTrack 11 Nov 27 19:53:09 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 27 19:53:09 volumio volumio[1166]: info: CoreCommandRouter::volumioPushState Nov 27 19:53:09 volumio volumio[1166]: info: CorePlayQueue::getTrack 11 Nov 27 19:53:09 volumio volumio[1166]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Nov 27 19:53:09 volumio volumio[1166]: verbose: CURRENT POSITION 11 Nov 27 19:53:09 volumio volumio[1166]: info: CoreStateMachine::syncState stateService stop Nov 27 19:53:09 volumio volumio[1166]: info: CoreStateMachine::syncState currentStatus stop Nov 27 19:53:09 volumio volumio[1166]: info: CoreStateMachine::pushState Nov 27 19:53:09 volumio volumio[1166]: info: CorePlayQueue::getTrack 11 Nov 27 19:53:09 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 27 19:53:09 volumio volumio[1166]: info: CoreCommandRouter::volumioPushState Nov 27 19:53:09 volumio volumio[1166]: info: No code Nov 27 19:53:09 volumio volumio[1166]: info: CoreStateMachine::pushState Nov 27 19:53:09 volumio volumio[1166]: info: CorePlayQueue::getTrack 11 Nov 27 19:53:09 volumio volumio[1166]: info: CoreCommandRouter::volumioPushState Nov 27 19:53:09 volumio volumio[1166]: info: ------------------------------ 80ms Nov 27 19:53:09 volumio kernel: scsi 0:0:0:0: Direct-Access ST950042 0AS 0006 PQ: 0 ANSI: 6 Nov 27 19:53:09 volumio kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0 Nov 27 19:53:09 volumio kernel: sd 0:0:0:0: [sda] 976773164 512-byte logical blocks: (500 GB/466 GiB) Nov 27 19:53:09 volumio kernel: sd 0:0:0:0: [sda] Write Protect is off Nov 27 19:53:09 volumio kernel: sd 0:0:0:0: [sda] Mode Sense: 2f 00 00 00 Nov 27 19:53:09 volumio kernel: sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA Nov 27 19:53:09 volumio kernel: sda: sda1 Nov 27 19:53:09 volumio kernel: sd 0:0:0:0: [sda] Attached SCSI disk Nov 27 19:53:10 volumio volumio[1166]: info: Mounting Device 新加卷 Nov 27 19:53:10 volumio sudo[2100]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/新加卷 -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Nov 27 19:53:10 volumio sudo[2100]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 27 19:53:10 volumio ntfs-3g[2103]: Version 2017.3.23AR.3 integrated FUSE 28 Nov 27 19:53:10 volumio ntfs-3g[2103]: Mounted /dev/sda1 (Read-Write, label "新加卷", NTFS 3.1) Nov 27 19:53:10 volumio ntfs-3g[2103]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Nov 27 19:53:10 volumio ntfs-3g[2103]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda1,blkdev,blksize=4096 Nov 27 19:53:10 volumio ntfs-3g[2103]: Global ownership and permissions enforced, configuration type 7 Nov 27 19:53:10 volumio sudo[2100]: pam_unix(sudo:session): session closed for user root Nov 27 19:53:10 volumio volumio[1166]: info: Scanning new location : "USB/新加卷" Nov 27 19:53:10 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand status Nov 27 19:53:10 volumio volumio[1166]: info: Nov 27 19:53:10 volumio volumio[1166]: ---------------------------- MPD announces state update: update Nov 27 19:53:10 volumio volumio[1166]: info: ControllerMpd::getState Nov 27 19:53:10 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand status Nov 27 19:53:10 volumio volumio[1166]: info: sendMpdCommand status took 2 milliseconds Nov 27 19:53:10 volumio volumio[1166]: info: sendMpdCommand status took 1 milliseconds Nov 27 19:53:10 volumio volumio[1166]: verbose: ControllerMpd::parseState Nov 27 19:53:10 volumio volumio[1166]: info: Command Router : Notfying DB Updatetrue Nov 27 19:53:10 volumio volumio[1166]: info: CoreCommandRouter::Close All Modals sent Nov 27 19:53:10 volumio volumio[1166]: verbose: ControllerMpd::parseState Nov 27 19:53:10 volumio volumio[1166]: info: ControllerMpd::pushState Nov 27 19:53:10 volumio volumio[1166]: info: CoreCommandRouter::servicePushState Nov 27 19:53:10 volumio volumio[1166]: info: CoreStateMachine::pushState Nov 27 19:53:10 volumio volumio[1166]: info: CorePlayQueue::getTrack 11 Nov 27 19:53:10 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 27 19:53:10 volumio volumio[1166]: info: CoreCommandRouter::volumioPushState Nov 27 19:53:10 volumio volumio[1166]: info: CorePlayQueue::getTrack 11 Nov 27 19:53:10 volumio volumio[1166]: 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} Nov 27 19:53:10 volumio volumio[1166]: verbose: CURRENT POSITION 11 Nov 27 19:53:10 volumio volumio[1166]: info: CoreStateMachine::syncState stateService stop Nov 27 19:53:10 volumio volumio[1166]: info: CoreStateMachine::syncState currentStatus stop Nov 27 19:53:10 volumio volumio[1166]: info: CoreStateMachine::pushState Nov 27 19:53:10 volumio volumio[1166]: info: CorePlayQueue::getTrack 11 Nov 27 19:53:10 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 27 19:53:10 volumio volumio[1166]: info: CoreCommandRouter::volumioPushState Nov 27 19:53:10 volumio volumio[1166]: info: No code Nov 27 19:53:10 volumio volumio[1166]: info: CoreStateMachine::pushState Nov 27 19:53:10 volumio volumio[1166]: info: CorePlayQueue::getTrack 11 Nov 27 19:53:10 volumio volumio[1166]: info: CoreCommandRouter::volumioPushState Nov 27 19:53:10 volumio volumio[1166]: info: ------------------------------ 135ms Nov 27 19:53:14 volumio volumio[1166]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Nov 27 19:53:14 volumio volumio[1166]: info: Retrying Login Due to Network Error Nov 27 19:53:19 volumio volumio[1166]: info: CoreCommandRouter::volumioPlay Nov 27 19:53:19 volumio volumio[1166]: info: CoreStateMachine::play index 11 Nov 27 19:53:19 volumio volumio[1166]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 27 19:53:19 volumio volumio[1166]: info: CoreStateMachine::stop Nov 27 19:53:19 volumio volumio[1166]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 27 19:53:19 volumio volumio[1166]: info: CoreStateMachine::play index undefined Nov 27 19:53:19 volumio volumio[1166]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 27 19:53:19 volumio volumio[1166]: info: CorePlayQueue::getTrack 11 Nov 27 19:53:19 volumio volumio[1166]: info: CoreStateMachine::startPlaybackTimer Nov 27 19:53:19 volumio volumio[1166]: info: CorePlayQueue::getTrack 11 Nov 27 19:53:19 volumio volumio[1166]: verbose: ControllerMpd::clearAddPlayTracks USB/新加卷/群星-《2009流行发烧唱片·极品靓声.DSD》.专辑.(ape).ape Nov 27 19:53:19 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand stop Nov 27 19:53:19 volumio volumio[1166]: info: sendMpdCommand stop took 1 milliseconds Nov 27 19:53:19 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand clear Nov 27 19:53:19 volumio volumio[1166]: info: Nov 27 19:53:19 volumio volumio[1166]: ---------------------------- MPD announces system playlist update Nov 27 19:53:19 volumio volumio[1166]: info: Ignoring MPD Status Update Nov 27 19:53:19 volumio volumio[1166]: info: sendMpdCommand clear took 0 milliseconds Nov 27 19:53:19 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand add "USB/新加卷/群星-《2009流行发烧唱片·极品靓声.DSD》.专辑.(ape).ape" Nov 27 19:53:19 volumio volumio[1166]: error: updateQueue error: null Nov 27 19:53:19 volumio volumio[1166]: info: Nov 27 19:53:19 volumio volumio[1166]: ---------------------------- MPD announces system playlist update Nov 27 19:53:19 volumio volumio[1166]: info: Ignoring MPD Status Update Nov 27 19:53:19 volumio volumio[1166]: info: ------------------------------ 1ms Nov 27 19:53:19 volumio volumio[1166]: info: sendMpdCommand add "USB/新加卷/群星-《2009流行发烧唱片·极品靓声.DSD》.专辑.(ape).ape" took 0 milliseconds Nov 27 19:53:19 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand play Nov 27 19:53:19 volumio volumio[1166]: info: ------------------------------ 1ms Nov 27 19:53:19 volumio volumio[1166]: info: sendMpdCommand play took 0 milliseconds Nov 27 19:53:19 volumio volumio[1166]: info: Nov 27 19:53:19 volumio volumio[1166]: ---------------------------- MPD announces state update: player Nov 27 19:53:19 volumio volumio[1166]: info: ControllerMpd::getState Nov 27 19:53:19 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand status Nov 27 19:53:19 volumio volumio[1166]: info: Nov 27 19:53:19 volumio volumio[1166]: ---------------------------- MPD announces state update: player Nov 27 19:53:19 volumio volumio[1166]: info: sendMpdCommand status took 35 milliseconds Nov 27 19:53:19 volumio volumio[1166]: info: ControllerMpd::getState Nov 27 19:53:19 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand status Nov 27 19:53:19 volumio volumio[1166]: verbose: ControllerMpd::parseState Nov 27 19:53:19 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 27 19:53:19 volumio volumio[1166]: info: sendMpdCommand status took 1 milliseconds Nov 27 19:53:19 volumio volumio[1166]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 27 19:53:19 volumio volumio[1166]: verbose: ControllerMpd::parseState Nov 27 19:53:19 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 27 19:53:19 volumio volumio[1166]: verbose: ControllerMpd::parseTrackInfo Nov 27 19:53:19 volumio volumio[1166]: info: ControllerMpd::pushState Nov 27 19:53:19 volumio volumio[1166]: info: CoreCommandRouter::servicePushState Nov 27 19:53:19 volumio volumio[1166]: info: CorePlayQueue::getTrack 11 Nov 27 19:53:19 volumio volumio[1166]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":4327,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"群星-《2009流行发烧唱片·极品靓声.DSD》.专辑.(ape).ape","artist":null,"album":null,"uri":"USB/新加卷/群星-《2009流行发烧唱片·极品靓声.DSD》.专辑.(ape).ape","trackType":"ape"} Nov 27 19:53:19 volumio volumio[1166]: verbose: CURRENT POSITION 11 Nov 27 19:53:19 volumio volumio[1166]: info: CoreStateMachine::syncState stateService play Nov 27 19:53:19 volumio volumio[1166]: info: CoreStateMachine::syncState currentStatus stop Nov 27 19:53:19 volumio volumio[1166]: info: ------------------------------ 39ms Nov 27 19:53:19 volumio volumio[1166]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 27 19:53:19 volumio volumio[1166]: verbose: ControllerMpd::parseTrackInfo Nov 27 19:53:19 volumio volumio[1166]: info: ControllerMpd::pushState Nov 27 19:53:19 volumio volumio[1166]: info: CoreCommandRouter::servicePushState Nov 27 19:53:19 volumio volumio[1166]: info: CorePlayQueue::getTrack 11 Nov 27 19:53:19 volumio volumio[1166]: verbose: STATE SERVICE {"status":"play","position":0,"seek":434,"duration":4327,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"群星-《2009流行发烧唱片·极品靓声.DSD》.专辑.(ape).ape","artist":null,"album":null,"uri":"USB/新加卷/群星-《2009流行发烧唱片·极品靓声.DSD》.专辑.(ape).ape","trackType":"ape"} Nov 27 19:53:19 volumio volumio[1166]: verbose: CURRENT POSITION 11 Nov 27 19:53:19 volumio volumio[1166]: info: CoreStateMachine::syncState stateService play Nov 27 19:53:19 volumio volumio[1166]: info: CoreStateMachine::syncState currentStatus play Nov 27 19:53:19 volumio volumio[1166]: info: Received an update from plugin. extracting info from payload Nov 27 19:53:19 volumio volumio[1166]: info: CoreStateMachine::pushState Nov 27 19:53:19 volumio volumio[1166]: info: CorePlayQueue::getTrack 11 Nov 27 19:53:19 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 27 19:53:19 volumio volumio[1166]: info: CoreCommandRouter::volumioPushState Nov 27 19:53:19 volumio volumio[1166]: info: CoreStateMachine::pushState Nov 27 19:53:19 volumio volumio[1166]: info: CorePlayQueue::getTrack 11 Nov 27 19:53:19 volumio volumio[1166]: info: CoreCommandRouter::volumioPushState Nov 27 19:53:19 volumio volumio[1166]: info: ------------------------------ 13ms Nov 27 19:53:21 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 27 19:53:21 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 27 19:53:21 volumio volumio[1166]: info: Discovery: Getting this device information Nov 27 19:53:21 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Nov 27 19:53:21 volumio volumio[1166]: info: CorePlayQueue::getTrack 11 Nov 27 19:53:21 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 27 19:53:24 volumio volumio[1166]: info: MyVolumio login type: Token Nov 27 19:53:24 volumio volumio[1166]: info: CoreCommandRouter::volumioPlay Nov 27 19:53:24 volumio volumio[1166]: info: CoreStateMachine::play index 15 Nov 27 19:53:24 volumio volumio[1166]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 27 19:53:24 volumio volumio[1166]: info: CoreStateMachine::stop Nov 27 19:53:24 volumio volumio[1166]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 27 19:53:24 volumio volumio[1166]: info: CoreStateMachine::stPlaybackTimer Nov 27 19:53:24 volumio volumio[1166]: info: CoreStateMachine::updateTrackBlock Nov 27 19:53:24 volumio volumio[1166]: info: CorePlayQueue::getTrackBlock Nov 27 19:53:24 volumio volumio[1166]: info: CoreStateMachine::pushState Nov 27 19:53:24 volumio volumio[1166]: info: CorePlayQueue::getTrack 11 Nov 27 19:53:24 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 27 19:53:24 volumio volumio[1166]: info: CoreCommandRouter::volumioPushState Nov 27 19:53:24 volumio volumio[1166]: info: CoreStateMachine::serviceStop Nov 27 19:53:24 volumio volumio[1166]: info: CorePlayQueue::getTrack 11 Nov 27 19:53:24 volumio volumio[1166]: info: CoreCommandRouter::serviceStop Nov 27 19:53:24 volumio volumio[1166]: info: ControllerMpd::stop Nov 27 19:53:24 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand stop Nov 27 19:53:24 volumio volumio[1166]: info: touch_display: Setting screensaver timeout to 120 seconds. Nov 27 19:53:25 volumio volumio[1166]: info: sendMpdCommand stop took 201 milliseconds Nov 27 19:53:25 volumio volumio[1166]: info: CoreStateMachine::play index undefined Nov 27 19:53:25 volumio volumio[1166]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 27 19:53:25 volumio volumio[1166]: info: CorePlayQueue::getTrack 15 Nov 27 19:53:25 volumio volumio[1166]: info: CoreStateMachine::startPlaybackTimer Nov 27 19:53:25 volumio volumio[1166]: info: CorePlayQueue::getTrack 15 Nov 27 19:53:25 volumio volumio[1166]: verbose: ControllerMpd::clearAddPlayTracks USB/新加卷/群星.-.[歌声飘过30年.(德国老虎鱼原装母盘)].专辑.(FLAC).flac Nov 27 19:53:25 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand stop Nov 27 19:53:25 volumio volumio[1166]: info: Nov 27 19:53:25 volumio volumio[1166]: ---------------------------- MPD announces state update: player Nov 27 19:53:25 volumio volumio[1166]: info: ControllerMpd::getState Nov 27 19:53:25 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand status Nov 27 19:53:25 volumio volumio[1166]: info: sendMpdCommand stop took 1 milliseconds Nov 27 19:53:25 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand clear Nov 27 19:53:25 volumio volumio[1166]: info: Nov 27 19:53:25 volumio volumio[1166]: ---------------------------- MPD announces system playlist update Nov 27 19:53:25 volumio volumio[1166]: info: Ignoring MPD Status Update Nov 27 19:53:25 volumio volumio[1166]: info: sendMpdCommand status took 0 milliseconds Nov 27 19:53:25 volumio volumio[1166]: info: sendMpdCommand clear took 1 milliseconds Nov 27 19:53:25 volumio volumio[1166]: verbose: ControllerMpd::parseState Nov 27 19:53:25 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 27 19:53:25 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand add "USB/新加卷/群星.-.[歌声飘过30年.(德国老虎鱼原装母盘)].专辑.(FLAC).flac" Nov 27 19:53:25 volumio volumio[1166]: error: updateQueue error: null Nov 27 19:53:25 volumio volumio[1166]: info: Nov 27 19:53:25 volumio volumio[1166]: ---------------------------- MPD announces system playlist update Nov 27 19:53:25 volumio volumio[1166]: info: Ignoring MPD Status Update Nov 27 19:53:25 volumio volumio[1166]: info: ------------------------------ 2ms Nov 27 19:53:25 volumio volumio[1166]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 27 19:53:25 volumio volumio[1166]: info: sendMpdCommand add "USB/新加卷/群星.-.[歌声飘过30年.(德国老虎鱼原装母盘)].专辑.(FLAC).flac" took 1 milliseconds Nov 27 19:53:25 volumio volumio[1166]: verbose: ControllerMpd::parseTrackInfo Nov 27 19:53:25 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand play Nov 27 19:53:25 volumio volumio[1166]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Nov 27 19:53:25 volumio volumio[1166]: info: ------------------------------ 5ms Nov 27 19:53:25 volumio volumio[1166]: info: ------------------------------ 4ms Nov 27 19:53:25 volumio volumio[1166]: info: sendMpdCommand play took 3 milliseconds Nov 27 19:53:25 volumio volumio[1166]: info: Nov 27 19:53:25 volumio volumio[1166]: ---------------------------- MPD announces state update: player Nov 27 19:53:25 volumio volumio[1166]: info: ControllerMpd::getState Nov 27 19:53:25 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand status Nov 27 19:53:25 volumio volumio[1166]: info: sendMpdCommand status took 20 milliseconds Nov 27 19:53:25 volumio volumio[1166]: verbose: ControllerMpd::parseState Nov 27 19:53:25 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 27 19:53:25 volumio volumio[1166]: info: Nov 27 19:53:25 volumio volumio[1166]: ---------------------------- MPD announces state update: player Nov 27 19:53:25 volumio volumio[1166]: info: ControllerMpd::getState Nov 27 19:53:25 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand status Nov 27 19:53:25 volumio volumio[1166]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 27 19:53:25 volumio volumio[1166]: verbose: ControllerMpd::parseTrackInfo Nov 27 19:53:25 volumio volumio[1166]: info: ControllerMpd::pushState Nov 27 19:53:25 volumio volumio[1166]: info: CoreCommandRouter::servicePushState Nov 27 19:53:25 volumio volumio[1166]: info: CorePlayQueue::getTrack 15 Nov 27 19:53:25 volumio volumio[1166]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":2226,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"群星.-.[歌声飘过30年.(德国老虎鱼原装母盘)].专辑.(FLAC).flac","artist":null,"album":"Unknown Title","uri":"USB/新加卷/群星.-.[歌声飘过30年.(德国老虎鱼原装母盘)].专辑.(FLAC).flac","trackType":"flac"} Nov 27 19:53:25 volumio volumio[1166]: verbose: CURRENT POSITION 15 Nov 27 19:53:25 volumio volumio[1166]: info: CoreStateMachine::syncState stateService play Nov 27 19:53:25 volumio volumio[1166]: info: CoreStateMachine::syncState currentStatus stop Nov 27 19:53:25 volumio volumio[1166]: info: ------------------------------ 24ms Nov 27 19:53:25 volumio volumio[1166]: info: sendMpdCommand status took 1 milliseconds Nov 27 19:53:25 volumio volumio[1166]: verbose: ControllerMpd::parseState Nov 27 19:53:25 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 27 19:53:25 volumio volumio[1166]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 27 19:53:25 volumio volumio[1166]: verbose: ControllerMpd::parseTrackInfo Nov 27 19:53:25 volumio volumio[1166]: info: ControllerMpd::pushState Nov 27 19:53:25 volumio volumio[1166]: info: CoreCommandRouter::servicePushState Nov 27 19:53:25 volumio volumio[1166]: info: CorePlayQueue::getTrack 15 Nov 27 19:53:25 volumio volumio[1166]: verbose: STATE SERVICE {"status":"play","position":0,"seek":434,"duration":2226,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"819 Kbps","isStreaming":false,"title":"群星.-.[歌声飘过30年.(德国老虎鱼原装母盘)].专辑.(FLAC).flac","artist":null,"album":"Unknown Title","uri":"USB/新加卷/群星.-.[歌声飘过30年.(德国老虎鱼原装母盘)].专辑.(FLAC).flac","trackType":"flac"} Nov 27 19:53:25 volumio volumio[1166]: verbose: CURRENT POSITION 15 Nov 27 19:53:25 volumio volumio[1166]: info: CoreStateMachine::syncState stateService play Nov 27 19:53:25 volumio volumio[1166]: info: CoreStateMachine::syncState currentStatus play Nov 27 19:53:25 volumio volumio[1166]: info: Received an update from plugin. extracting info from payload Nov 27 19:53:25 volumio volumio[1166]: info: CoreStateMachine::pushState Nov 27 19:53:25 volumio volumio[1166]: info: CorePlayQueue::getTrack 15 Nov 27 19:53:25 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 27 19:53:25 volumio volumio[1166]: info: CoreCommandRouter::volumioPushState Nov 27 19:53:25 volumio volumio[1166]: info: CoreStateMachine::pushState Nov 27 19:53:25 volumio volumio[1166]: info: CorePlayQueue::getTrack 15 Nov 27 19:53:25 volumio volumio[1166]: info: CoreCommandRouter::volumioPushState Nov 27 19:53:25 volumio volumio[1166]: info: ------------------------------ 15ms Nov 27 19:53:51 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 27 19:53:51 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 27 19:53:51 volumio volumio[1166]: info: Discovery: Getting this device information Nov 27 19:53:51 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Nov 27 19:53:51 volumio volumio[1166]: info: CorePlayQueue::getTrack 15 Nov 27 19:53:51 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 27 19:53:54 volumio volumio[1166]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Nov 27 19:53:54 volumio volumio[1166]: info: Retrying Login Due to Network Error Nov 27 19:54:04 volumio volumio[1166]: info: MyVolumio login type: Token Nov 27 19:54:21 volumio volumio[1166]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 7 Nov 27 19:54:21 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Nov 27 19:54:21 volumio volumio[1166]: info: CorePlayQueue::getTrack 15 Nov 27 19:54:25 volumio volumio[1166]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 8 Nov 27 19:54:25 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Nov 27 19:54:25 volumio volumio[1166]: info: CorePlayQueue::getTrack 15 Nov 27 19:54:33 volumio volumio[1166]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 27 19:54:33 volumio volumio[1166]: Error: connect ETIMEDOUT 103.252.115.49:443 Nov 27 19:54:33 volumio volumio[1166]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Nov 27 19:54:33 volumio volumio[1166]: errno: -110, Nov 27 19:54:33 volumio volumio[1166]: code: 'ETIMEDOUT', Nov 27 19:54:33 volumio volumio[1166]: syscall: 'connect', Nov 27 19:54:33 volumio volumio[1166]: address: '103.252.115.49', Nov 27 19:54:33 volumio volumio[1166]: port: 443 Nov 27 19:54:33 volumio volumio[1166]: } Nov 27 19:54:33 volumio volumio[1166]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 27 19:54:33 volumio sudo[2545]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-27 19:53 Nov 27 19:54:33 volumio sudo[2545]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 06:51:56 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="b9009e0280f50389e80a537357ff3961"