-- Logs begin at Thu 2019-02-14 10:11:59 UTC, end at Sun 2024-08-25 08:54:10 UTC. -- Aug 25 08:53:06 volumio kernel: usb 2-1: USB disconnect, device number 2 Aug 25 08:53:06 volumio volumio[925]: info: Partition removed: {"syspath":"/sys/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.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-path/platform-fd500000.pcie-pci-0000:01:00.0-usb-0:1:1.0-scsi-0:0:0:0-part1 /dev/disk/by-id/usb-WD_My_Passport_25E1_5758383141433635525A385A-0:0-part1 /dev/disk/by-partuuid/f36a6b48-01 /dev/disk/by-uuid/E4AE-6C6D","DEVNAME":"/dev/sda1","DEVPATH":"/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb2/2-1/2-1:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","DEVTYPE":"partition","ID_BUS":"usb","ID_FS_TYPE":"exfat","ID_FS_USAGE":"filesystem","ID_FS_UUID":"E4AE-6C6D","ID_FS_UUID_ENC":"E4AE-6C6D","ID_FS_VERSION":"1.0","ID_INSTANCE":"0:0","ID_MODEL":"My_Passport_25E1","ID_MODEL_ENC":"My\\x20Passport\\x2025E1","ID_MODEL_ID":"25e1","ID_PART_ENTRY_DISK":"8:0","ID_PART_ENTRY_FLAGS":"0x80","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"2048","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"1953456128","ID_PART_ENTRY_TYPE":"0xc","ID_PART_ENTRY_UUID":"f36a6b48-01","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"f36a6b48","ID_PATH":"platform-fd500000.pcie-pci-0000:01:00.0-usb-0:1:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-fd500000_pcie-pci-0000_01_00_0-usb-0_1_1_0-scsi-0_0_0_0","ID_REVISION":"1015","ID_SERIAL":"WD_My_Passport_25E1_5758383141433635525A385A-0:0","ID_SERIAL_SHORT":"5758383141433635525A385A","ID_TYPE":"disk","ID_USB_DRIVER":"usb-storage","ID_USB_INTERFACES":":080650:","ID_USB_INTERFACE_NUM":"00","ID_VENDOR":"WD","ID_VENDOR_ENC":"WD\\x20\\x20\\x20\\x20\\x20\\x20","ID_VENDOR_ID":"1058","MAJOR":"8","MINOR":"1","PARTN":"1","SEQNUM":"1748","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"14328967"} Aug 25 08:53:06 volumio sudo[1667]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sda1 Aug 25 08:53:06 volumio sudo[1667]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 25 08:53:06 volumio systemd[1]: media-E4AE\x2d6C6D.mount: Succeeded. Aug 25 08:53:06 volumio sudo[1667]: pam_unix(sudo:session): session closed for user root Aug 25 08:53:06 volumio mount.exfat[975]: failed to write super block Aug 25 08:53:09 volumio kernel: usb 1-1.3: new high-speed USB device number 4 using xhci_hcd Aug 25 08:53:09 volumio kernel: usb 1-1.3: New USB device found, idVendor=1058, idProduct=25e1, bcdDevice=10.15 Aug 25 08:53:09 volumio kernel: usb 1-1.3: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Aug 25 08:53:09 volumio kernel: usb 1-1.3: Product: My Passport 25E1 Aug 25 08:53:09 volumio kernel: usb 1-1.3: Manufacturer: Western Digital Aug 25 08:53:09 volumio kernel: usb 1-1.3: SerialNumber: 5758383141433635525A385A Aug 25 08:53:09 volumio kernel: usb-storage 1-1.3:1.0: USB Mass Storage device detected Aug 25 08:53:09 volumio kernel: scsi host0: usb-storage 1-1.3:1.0 Aug 25 08:53:10 volumio kernel: scsi 0:0:0:0: Direct-Access WD My Passport 25E1 1015 PQ: 0 ANSI: 6 Aug 25 08:53:10 volumio kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0 Aug 25 08:53:10 volumio kernel: scsi 0:0:0:1: Enclosure WD SES Device 1015 PQ: 0 ANSI: 6 Aug 25 08:53:10 volumio kernel: sd 0:0:0:0: [sda] Spinning up disk... Aug 25 08:53:10 volumio kernel: scsi 0:0:0:1: Attached scsi generic sg1 type 13 Aug 25 08:53:10 volumio volumio[925]: info: TEST: Here we shall have deleted mounted folder: /mnt/USB/E4AE-6C6D Aug 25 08:53:11 volumio volumio[925]: info: Scanning removed location : "USB/E4AE-6C6D" Aug 25 08:53:11 volumio volumio[925]: verbose: ControllerMpd::sendMpdCommand status Aug 25 08:53:11 volumio volumio[925]: info: Aug 25 08:53:11 volumio volumio[925]: ---------------------------- MPD announces state update: update Aug 25 08:53:11 volumio volumio[925]: info: ControllerMpd::getState Aug 25 08:53:11 volumio volumio[925]: verbose: ControllerMpd::sendMpdCommand status Aug 25 08:53:11 volumio volumio[925]: verbose: ControllerMpd::sendMpdCommand status Aug 25 08:53:11 volumio volumio[925]: info: Aug 25 08:53:11 volumio volumio[925]: ---------------------------- MPD announces state update: update Aug 25 08:53:11 volumio volumio[925]: info: ControllerMpd::getState Aug 25 08:53:11 volumio volumio[925]: verbose: ControllerMpd::sendMpdCommand status Aug 25 08:53:11 volumio volumio[925]: info: sendMpdCommand status took 3 milliseconds Aug 25 08:53:11 volumio volumio[925]: info: sendMpdCommand status took 3 milliseconds Aug 25 08:53:11 volumio volumio[925]: verbose: ControllerMpd::parseState Aug 25 08:53:11 volumio volumio[925]: info: Command Router : Notfying DB Updatefalse Aug 25 08:53:11 volumio volumio[925]: info: CoreCommandRouter::Close All Modals sent Aug 25 08:53:11 volumio volumio[925]: verbose: ControllerMpd::parseState Aug 25 08:53:11 volumio volumio[925]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 25 08:53:11 volumio volumio[925]: info: sendMpdCommand status took 43 milliseconds Aug 25 08:53:11 volumio volumio[925]: info: sendMpdCommand status took 43 milliseconds Aug 25 08:53:11 volumio volumio[925]: info: sendMpdCommand playlistinfo took 3 milliseconds Aug 25 08:53:11 volumio volumio[925]: verbose: ControllerMpd::parseState Aug 25 08:53:11 volumio volumio[925]: info: Command Router : Notfying DB Updatefalse Aug 25 08:53:11 volumio volumio[925]: info: CoreCommandRouter::Close All Modals sent Aug 25 08:53:11 volumio volumio[925]: verbose: ControllerMpd::parseState Aug 25 08:53:11 volumio volumio[925]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 25 08:53:11 volumio volumio[925]: verbose: ControllerMpd::parseTrackInfo Aug 25 08:53:11 volumio volumio[925]: info: ControllerMpd::pushState Aug 25 08:53:11 volumio volumio[925]: info: CoreCommandRouter::servicePushState Aug 25 08:53:11 volumio volumio[925]: info: CoreStateMachine::pushState Aug 25 08:53:11 volumio volumio[925]: info: CorePlayQueue::getTrack 0 Aug 25 08:53:11 volumio volumio[925]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 25 08:53:11 volumio volumio[925]: info: CoreCommandRouter::volumioPushState Aug 25 08:53:11 volumio volumio[925]: info: CorePlayQueue::getTrack 0 Aug 25 08:53:11 volumio volumio[925]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Aug 25 08:53:11 volumio volumio[925]: info: ------------------------------ 82ms Aug 25 08:53:11 volumio volumio[925]: info: sendMpdCommand playlistinfo took 27 milliseconds Aug 25 08:53:11 volumio volumio[925]: verbose: ControllerMpd::parseTrackInfo Aug 25 08:53:11 volumio volumio[925]: info: ControllerMpd::pushState Aug 25 08:53:11 volumio volumio[925]: info: CoreCommandRouter::servicePushState Aug 25 08:53:11 volumio volumio[925]: info: CoreStateMachine::pushState Aug 25 08:53:11 volumio volumio[925]: info: CorePlayQueue::getTrack 0 Aug 25 08:53:11 volumio volumio[925]: info: CoreCommandRouter::volumioPushState Aug 25 08:53:11 volumio volumio[925]: info: CorePlayQueue::getTrack 0 Aug 25 08:53:11 volumio volumio[925]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Aug 25 08:53:11 volumio volumio[925]: info: ------------------------------ 99ms Aug 25 08:53:14 volumio kernel: ....ready Aug 25 08:53:14 volumio kernel: sd 0:0:0:0: [sda] 1953458176 512-byte logical blocks: (1.00 TB/931 GiB) Aug 25 08:53:14 volumio kernel: sd 0:0:0:0: [sda] Write Protect is off Aug 25 08:53:14 volumio kernel: sd 0:0:0:0: [sda] Mode Sense: 47 00 10 08 Aug 25 08:53:14 volumio kernel: sd 0:0:0:0: [sda] No Caching mode page found Aug 25 08:53:14 volumio kernel: sd 0:0:0:0: [sda] Assuming drive cache: write through Aug 25 08:53:14 volumio kernel: sda: sda1 Aug 25 08:53:14 volumio kernel: sd 0:0:0:0: [sda] Attached SCSI disk Aug 25 08:53:15 volumio volumio[925]: info: Mounting Device E4AE-6C6D Aug 25 08:53:15 volumio sudo[1688]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/E4AE-6C6D -o noatime Aug 25 08:53:15 volumio sudo[1688]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 25 08:53:15 volumio mount.exfat[1690]: volume was not unmounted cleanly Aug 25 08:53:15 volumio sudo[1688]: pam_unix(sudo:session): session closed for user root Aug 25 08:53:15 volumio volumio[925]: WARN: volume was not unmounted cleanly. Aug 25 08:53:15 volumio volumio[925]: info: Scanning new location : "USB/E4AE-6C6D" Aug 25 08:53:15 volumio volumio[925]: verbose: ControllerMpd::sendMpdCommand status Aug 25 08:53:15 volumio volumio[925]: info: Aug 25 08:53:15 volumio volumio[925]: ---------------------------- MPD announces state update: update Aug 25 08:53:15 volumio volumio[925]: info: ControllerMpd::getState Aug 25 08:53:15 volumio volumio[925]: verbose: ControllerMpd::sendMpdCommand status Aug 25 08:53:15 volumio volumio[925]: info: sendMpdCommand status took 8 milliseconds Aug 25 08:53:15 volumio volumio[925]: info: sendMpdCommand status took 7 milliseconds Aug 25 08:53:15 volumio volumio[925]: verbose: ControllerMpd::parseState Aug 25 08:53:15 volumio volumio[925]: info: Command Router : Notfying DB Updatetrue Aug 25 08:53:15 volumio volumio[925]: info: CoreCommandRouter::Close All Modals sent Aug 25 08:53:15 volumio volumio[925]: verbose: ControllerMpd::parseState Aug 25 08:53:15 volumio volumio[925]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 25 08:53:15 volumio volumio[925]: info: sendMpdCommand playlistinfo took 2 milliseconds Aug 25 08:53:15 volumio volumio[925]: verbose: ControllerMpd::parseTrackInfo Aug 25 08:53:15 volumio volumio[925]: info: ControllerMpd::pushState Aug 25 08:53:15 volumio volumio[925]: info: CoreCommandRouter::servicePushState Aug 25 08:53:15 volumio volumio[925]: info: CoreStateMachine::pushState Aug 25 08:53:15 volumio volumio[925]: info: CorePlayQueue::getTrack 0 Aug 25 08:53:15 volumio volumio[925]: info: CoreCommandRouter::volumioPushState Aug 25 08:53:15 volumio volumio[925]: info: CorePlayQueue::getTrack 0 Aug 25 08:53:15 volumio volumio[925]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Aug 25 08:53:15 volumio volumio[925]: info: ------------------------------ 51ms Aug 25 08:53:22 volumio volumio[925]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 25 08:53:22 volumio volumio[925]: info: CURURI: music-library/USB Aug 25 08:53:22 volumio volumio[925]: info: Preload queue cleared Aug 25 08:53:24 volumio volumio[925]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 25 08:53:24 volumio volumio[925]: info: CURURI: music-library/USB/E4AE-6C6D Aug 25 08:53:24 volumio volumio[925]: info: Preload queue cleared Aug 25 08:53:26 volumio volumio[925]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 25 08:53:26 volumio volumio[925]: info: CURURI: music-library/USB/E4AE-6C6D/音乐 Aug 25 08:53:26 volumio volumio[925]: info: Preload queue cleared Aug 25 08:53:46 volumio volumio[925]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 25 08:53:46 volumio volumio[925]: info: CURURI: playlists Aug 25 08:53:46 volumio volumio[925]: info: Listing playlists Aug 25 08:53:46 volumio volumio[925]: info: Preload queue cleared Aug 25 08:54:10 volumio volumio[925]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 25 08:54:10 volumio volumio[925]: Error: connect ETIMEDOUT 202.160.128.203:80 Aug 25 08:54:10 volumio volumio[925]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Aug 25 08:54:10 volumio volumio[925]: errno: -110, Aug 25 08:54:10 volumio volumio[925]: code: 'ETIMEDOUT', Aug 25 08:54:10 volumio volumio[925]: syscall: 'connect', Aug 25 08:54:10 volumio volumio[925]: address: '202.160.128.203', Aug 25 08:54:10 volumio volumio[925]: port: 80 Aug 25 08:54:10 volumio volumio[925]: } Aug 25 08:54:10 volumio volumio[925]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 25 08:54:10 volumio sudo[1711]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-25 08:53 Aug 25 08:54:10 volumio sudo[1711]: 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="c87c6e2b1ae33dc5801986cbcbe970898b92e7b4" VOLUMIO_FE_VERSION="c433755e569617abac52264d17ad61be303ef463" VOLUMIO_FE3_VERSION="2419ddd8e895c5bdc456962163c9dc7c0f187aa7" VOLUMIO_BE_VERSION="b949d6001d7e656b4668f31c119d2247cdf45158" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 30 Mar 2023 05:45:03 PM CEST" VOLUMIO_VERSION="3.449" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="6428d8e2c06e98483f5c5d77e8f01989"