-- Logs begin at Thu 2019-02-14 18:11:58 CST, end at Fri 2025-12-26 18:42:55 CST. -- Dec 26 18:42:49 volumio kernel: usb 1-1.2: USB disconnect, device number 4 Dec 26 18:42:49 volumio sudo[6385]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sda1 Dec 26 18:42:49 volumio volumio[847]: info: Partition removed: {"syspath":"/sys/devices/platform/scb/fe9c0000.xhci/usb1/1-1/1-1.2/1-1.2:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","ACTION":"remove","DEVLINKS":"/dev/disk/by-path/platform-fe9c0000.xhci-usb-0:1.2:1.0-scsi-0:0:0:0-part1 /dev/disk/by-uuid/E878-DFE2 /dev/disk/by-id/usb-VendorCo_ProductCode_2216151160064170226-0:0-part1 /dev/disk/by-partuuid/01262852-01","DEVNAME":"/dev/sda1","DEVPATH":"/devices/platform/scb/fe9c0000.xhci/usb1/1-1/1-1.2/1-1.2:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","DEVTYPE":"partition","DISKSEQ":"26","ID_BUS":"usb","ID_FS_TYPE":"vfat","ID_FS_USAGE":"filesystem","ID_FS_UUID":"E878-DFE2","ID_FS_UUID_ENC":"E878-DFE2","ID_FS_VERSION":"FAT32","ID_INSTANCE":"0:0","ID_MODEL":"ProductCode","ID_MODEL_ENC":"ProductCode\\x20\\x20\\x20\\x20\\x20","ID_MODEL_ID":"5678","ID_PART_ENTRY_DISK":"8:0","ID_PART_ENTRY_FLAGS":"0x80","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"32","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"15728608","ID_PART_ENTRY_TYPE":"0xc","ID_PART_ENTRY_UUID":"01262852-01","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"01262852","ID_PATH":"platform-fe9c0000.xhci-usb-0:1.2:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-fe9c0000_xhci-usb-0_1_2_1_0-scsi-0_0_0_0","ID_REVISION":"2.00","ID_SERIAL":"VendorCo_ProductCode_2216151160064170226-0:0","ID_SERIAL_SHORT":"2216151160064170226","ID_TYPE":"disk","ID_USB_DRIVER":"usb-storage","ID_USB_INTERFACES":":080650:","ID_USB_INTERFACE_NUM":"00","ID_VENDOR":"VendorCo","ID_VENDOR_ENC":"VendorCo","ID_VENDOR_ID":"346d","MAJOR":"8","MINOR":"1","PARTN":"1","SEQNUM":"2400","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"4449245"} Dec 26 18:42:49 volumio volumio[847]: umount: /media/E878-DFE2: target is busy. Dec 26 18:42:49 volumio volumio[847]: error: Failed to umount E878-DFE2: Error: Command failed: /usr/bin/sudo /bin/umount -f "/dev/sda1" Dec 26 18:42:49 volumio volumio[847]: umount: /media/E878-DFE2: target is busy. Dec 26 18:42:49 volumio sudo[6385]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 18:42:49 volumio sudo[6385]: pam_unix(sudo:session): session closed for user root Dec 26 18:42:54 volumio volumio[847]: info: Scanning removed location : "USB/E878-DFE2" Dec 26 18:42:54 volumio volumio[847]: verbose: ControllerMpd::sendMpdCommand status Dec 26 18:42:54 volumio volumio[847]: info: Dec 26 18:42:54 volumio volumio[847]: ---------------------------- MPD announces state update: update Dec 26 18:42:54 volumio volumio[847]: info: ControllerMpd::getState Dec 26 18:42:54 volumio volumio[847]: verbose: ControllerMpd::sendMpdCommand status Dec 26 18:42:54 volumio kernel: FAT-fs (sda1): Directory bread(block 32768) failed Dec 26 18:42:54 volumio kernel: FAT-fs (sda1): Directory bread(block 32769) failed Dec 26 18:42:54 volumio kernel: FAT-fs (sda1): Directory bread(block 32770) failed Dec 26 18:42:54 volumio kernel: FAT-fs (sda1): Directory bread(block 32771) failed Dec 26 18:42:54 volumio kernel: FAT-fs (sda1): Directory bread(block 32772) failed Dec 26 18:42:54 volumio kernel: FAT-fs (sda1): Directory bread(block 32773) failed Dec 26 18:42:54 volumio kernel: FAT-fs (sda1): Directory bread(block 32774) failed Dec 26 18:42:54 volumio kernel: FAT-fs (sda1): Directory bread(block 32775) failed Dec 26 18:42:54 volumio kernel: FAT-fs (sda1): Directory bread(block 32768) failed Dec 26 18:42:54 volumio kernel: FAT-fs (sda1): Directory bread(block 32769) failed Dec 26 18:42:54 volumio volumio[847]: info: MPD Database updated - AlbumList cache refreshed Dec 26 18:42:54 volumio volumio[847]: info: Dec 26 18:42:54 volumio volumio[847]: ---------------------------- MPD announces state update: database Dec 26 18:42:54 volumio volumio[847]: verbose: ControllerMpd::sendMpdCommand status Dec 26 18:42:54 volumio volumio[847]: info: Dec 26 18:42:54 volumio volumio[847]: ---------------------------- MPD announces state update: update Dec 26 18:42:54 volumio volumio[847]: info: ControllerMpd::getState Dec 26 18:42:54 volumio volumio[847]: verbose: ControllerMpd::sendMpdCommand status Dec 26 18:42:54 volumio volumio[847]: info: ControllerMpd::getState Dec 26 18:42:54 volumio volumio[847]: verbose: ControllerMpd::sendMpdCommand status Dec 26 18:42:54 volumio volumio[847]: info: sendMpdCommand status took 77 milliseconds Dec 26 18:42:54 volumio volumio[847]: info: sendMpdCommand status took 76 milliseconds Dec 26 18:42:54 volumio volumio[847]: verbose: ControllerMpd::parseState Dec 26 18:42:55 volumio volumio[847]: info: Command Router : Notfying DB Updatefalse Dec 26 18:42:55 volumio volumio[847]: info: CoreCommandRouter::Close All Modals sent Dec 26 18:42:55 volumio volumio[847]: verbose: ControllerMpd::parseState Dec 26 18:42:55 volumio volumio[847]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 26 18:42:55 volumio volumio[847]: info: sendMpdCommand status took 66 milliseconds Dec 26 18:42:55 volumio volumio[847]: info: sendMpdCommand status took 66 milliseconds Dec 26 18:42:55 volumio volumio[847]: info: sendMpdCommand status took 65 milliseconds Dec 26 18:42:55 volumio volumio[847]: info: sendMpdCommand playlistinfo took 19 milliseconds Dec 26 18:42:55 volumio volumio[847]: verbose: ControllerMpd::parseState Dec 26 18:42:55 volumio volumio[847]: info: Command Router : Notfying DB Updatefalse Dec 26 18:42:55 volumio volumio[847]: info: CoreCommandRouter::Close All Modals sent Dec 26 18:42:55 volumio volumio[847]: verbose: ControllerMpd::parseState Dec 26 18:42:55 volumio volumio[847]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 26 18:42:55 volumio volumio[847]: verbose: ControllerMpd::parseState Dec 26 18:42:55 volumio volumio[847]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 26 18:42:55 volumio volumio[847]: verbose: ControllerMpd::parseTrackInfo Dec 26 18:42:55 volumio volumio[847]: info: ControllerMpd::pushState Dec 26 18:42:55 volumio volumio[847]: info: CoreCommandRouter::servicePushState Dec 26 18:42:55 volumio volumio[847]: info: CorePlayQueue::getTrack 4 Dec 26 18:42:55 volumio volumio[847]: verbose: STATE SERVICE {"status":"play","position":0,"seek":136994,"duration":271,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"蓝莲花","artist":"环绕声特调正版音乐","album":"国语老歌怀旧经典","uri":"USB/E878-DFE2/15.测试-蓝莲花（本专辑内置1500首正版歌曲）.mp3","trackType":"mp3"} Dec 26 18:42:55 volumio volumio[847]: verbose: CURRENT POSITION 4 Dec 26 18:42:55 volumio volumio[847]: info: CoreStateMachine::syncState stateService play Dec 26 18:42:55 volumio volumio[847]: info: CoreStateMachine::syncState currentStatus play Dec 26 18:42:55 volumio volumio[847]: info: Received an update from plugin. extracting info from payload Dec 26 18:42:55 volumio volumio[847]: info: CoreStateMachine::pushState Dec 26 18:42:55 volumio volumio[847]: info: CorePlayQueue::getTrack 4 Dec 26 18:42:55 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 26 18:42:55 volumio volumio[847]: info: CoreCommandRouter::volumioPushState Dec 26 18:42:55 volumio volumio[847]: info: CoreStateMachine::pushState Dec 26 18:42:55 volumio volumio[847]: info: CorePlayQueue::getTrack 4 Dec 26 18:42:55 volumio volumio[847]: info: CoreCommandRouter::volumioPushState Dec 26 18:42:55 volumio volumio[847]: info: ------------------------------ 186ms Dec 26 18:42:55 volumio volumio[847]: info: sendMpdCommand playlistinfo took 21 milliseconds Dec 26 18:42:55 volumio volumio[847]: info: sendMpdCommand playlistinfo took 20 milliseconds Dec 26 18:42:55 volumio volumio[847]: verbose: ControllerMpd::parseTrackInfo Dec 26 18:42:55 volumio volumio[847]: verbose: ControllerMpd::parseTrackInfo Dec 26 18:42:55 volumio volumio[847]: info: ControllerMpd::pushState Dec 26 18:42:55 volumio volumio[847]: info: CoreCommandRouter::servicePushState Dec 26 18:42:55 volumio volumio[847]: info: CorePlayQueue::getTrack 4 Dec 26 18:42:55 volumio volumio[847]: verbose: STATE SERVICE {"status":"play","position":0,"seek":136994,"duration":271,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"蓝莲花","artist":"环绕声特调正版音乐","album":"国语老歌怀旧经典","uri":"USB/E878-DFE2/15.测试-蓝莲花（本专辑内置1500首正版歌曲）.mp3","trackType":"mp3"} Dec 26 18:42:55 volumio volumio[847]: verbose: CURRENT POSITION 4 Dec 26 18:42:55 volumio volumio[847]: info: CoreStateMachine::syncState stateService play Dec 26 18:42:55 volumio volumio[847]: info: CoreStateMachine::syncState currentStatus play Dec 26 18:42:55 volumio volumio[847]: info: Received an update from plugin. extracting info from payload Dec 26 18:42:55 volumio volumio[847]: info: CoreStateMachine::pushState Dec 26 18:42:55 volumio volumio[847]: info: CorePlayQueue::getTrack 4 Dec 26 18:42:55 volumio volumio[847]: info: CoreCommandRouter::volumioPushState Dec 26 18:42:55 volumio volumio[847]: info: CoreStateMachine::pushState Dec 26 18:42:55 volumio volumio[847]: info: CorePlayQueue::getTrack 4 Dec 26 18:42:55 volumio volumio[847]: info: CoreCommandRouter::volumioPushState Dec 26 18:42:55 volumio volumio[847]: info: ControllerMpd::pushState Dec 26 18:42:55 volumio volumio[847]: info: CoreCommandRouter::servicePushState Dec 26 18:42:55 volumio volumio[847]: info: CorePlayQueue::getTrack 4 Dec 26 18:42:55 volumio volumio[847]: verbose: STATE SERVICE {"status":"play","position":0,"seek":136994,"duration":271,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"蓝莲花","artist":"环绕声特调正版音乐","album":"国语老歌怀旧经典","uri":"USB/E878-DFE2/15.测试-蓝莲花（本专辑内置1500首正版歌曲）.mp3","trackType":"mp3"} Dec 26 18:42:55 volumio volumio[847]: verbose: CURRENT POSITION 4 Dec 26 18:42:55 volumio volumio[847]: info: CoreStateMachine::syncState stateService play Dec 26 18:42:55 volumio volumio[847]: info: CoreStateMachine::syncState currentStatus play Dec 26 18:42:55 volumio volumio[847]: info: Received an update from plugin. extracting info from payload Dec 26 18:42:55 volumio volumio[847]: info: CoreStateMachine::pushState Dec 26 18:42:55 volumio volumio[847]: info: CorePlayQueue::getTrack 4 Dec 26 18:42:55 volumio volumio[847]: info: CoreCommandRouter::volumioPushState Dec 26 18:42:55 volumio volumio[847]: info: CoreStateMachine::pushState Dec 26 18:42:55 volumio volumio[847]: info: CorePlayQueue::getTrack 4 Dec 26 18:42:55 volumio volumio[847]: info: CoreCommandRouter::volumioPushState Dec 26 18:42:55 volumio volumio[847]: info: ------------------------------ 136ms Dec 26 18:42:55 volumio volumio[847]: info: ------------------------------ 135ms Dec 26 18:42:55 volumio volumio[847]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 26 18:42:55 volumio volumio[847]: Error: connect ETIMEDOUT 199.59.150.45:443 Dec 26 18:42:55 volumio volumio[847]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Dec 26 18:42:55 volumio volumio[847]: errno: -110, Dec 26 18:42:55 volumio volumio[847]: code: 'ETIMEDOUT', Dec 26 18:42:55 volumio volumio[847]: syscall: 'connect', Dec 26 18:42:55 volumio volumio[847]: address: '199.59.150.45', Dec 26 18:42:55 volumio volumio[847]: port: 443 Dec 26 18:42:55 volumio volumio[847]: } Dec 26 18:42:55 volumio volumio[847]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 26 18:42:55 volumio sudo[6404]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-26 18:41 Dec 26 18:42:55 volumio sudo[6404]: 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="29866754e5f1d7e4d0f581c10d9f22852f6f21db" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 10:25:36 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="cf6e14681b2ecbbdc9a62186b0f3114c"