-- Logs begin at Sun 2025-04-13 20:47:34 CST, end at Sun 2025-04-13 21:48:20 CST. -- Apr 13 21:47:23 volumio volumio[925]: verbose: New Socket.io Connection to 192.168.31.86 from 192.168.31.21 UA: Mozilla/5.0 (Linux; Android 10; HarmonyOS; EVR-AL00; HMSCore 6.15.0.302; GMSCore 20.15.16) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/99.0.4844.88 HuaweiBrowser/14.0.2.312 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Apr 13 21:47:23 volumio volumio[925]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 13 21:47:23 volumio volumio[925]: info: CoreCommandRouter::volumioGetVisibleSources Apr 13 21:47:23 volumio volumio[925]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 13 21:47:23 volumio volumio[925]: info: CoreCommandRouter::volumioGetState Apr 13 21:47:23 volumio volumio[925]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 13 21:47:23 volumio volumio[925]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 13 21:47:23 volumio volumio[925]: info: Received Get System Info Apr 13 21:47:23 volumio volumio[925]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 13 21:47:23 volumio volumio[925]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 13 21:47:23 volumio volumio[925]: info: Discovery: Getting this device information Apr 13 21:47:23 volumio volumio[925]: info: CoreCommandRouter::volumioGetState Apr 13 21:47:23 volumio volumio[925]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 13 21:47:23 volumio volumio[925]: info: CoreCommandRouter::volumioGetState Apr 13 21:47:23 volumio volumio[925]: info: Listing playlists Apr 13 21:47:23 volumio volumio[925]: info: CoreCommandRouter::volumioGetQueue Apr 13 21:47:23 volumio volumio[925]: info: CoreStateMachine::getQueue Apr 13 21:47:23 volumio volumio[925]: info: CorePlayQueue::getQueue Apr 13 21:47:24 volumio volumio[925]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Apr 13 21:47:24 volumio volumio[925]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E8%B5%B5%E8%81%AA/%E8%81%86%E5%90%AC%E4%B8%AD%E5%9B%BD/a3afcecc-8640-407c-9945-3208c75fa38a.jpg' Apr 13 21:47:33 volumio kernel: usb 6-2: USB disconnect, device number 2 Apr 13 21:47:33 volumio volumio[925]: info: Partition removed: {"syspath":"/sys/devices/pci0000:00/0000:00:10.0/usb6/6-2/6-2:1.0/host2/target2:0:0/2:0:0:0/block/sdb/sdb1","ACTION":"remove","DEVLINKS":"/dev/disk/by-id/usb-Kingston_DataTraveler_3.0_E0D55E55CC73B541394A03E0-0:0-part1 /dev/disk/by-label/KINGSTON /dev/disk/by-uuid/3EE8-1D7C /dev/disk/by-path/pci-0000:00:10.0-usb-0:2:1.0-scsi-0:0:0:0-part1 /dev/disk/by-partuuid/3ee81d7c-01","DEVNAME":"/dev/sdb1","DEVPATH":"/devices/pci0000:00/0000:00:10.0/usb6/6-2/6-2:1.0/host2/target2:0:0/2:0:0:0/block/sdb/sdb1","DEVTYPE":"partition","DISKSEQ":"11","ID_BUS":"usb","ID_FS_LABEL":"KINGSTON","ID_FS_LABEL_ENC":"KINGSTON","ID_FS_TYPE":"vfat","ID_FS_USAGE":"filesystem","ID_FS_UUID":"3EE8-1D7C","ID_FS_UUID_ENC":"3EE8-1D7C","ID_FS_VERSION":"FAT32","ID_INSTANCE":"0:0","ID_MODEL":"DataTraveler_3.0","ID_MODEL_ENC":"DataTraveler\\x203.0","ID_MODEL_ID":"1666","ID_PART_ENTRY_DISK":"8:16","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"109824","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"121099008","ID_PART_ENTRY_TYPE":"0xc","ID_PART_ENTRY_UUID":"3ee81d7c-01","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"3ee81d7c","ID_PATH":"pci-0000:00:10.0-usb-0:2:1.0-scsi-0:0:0:0","ID_PATH_TAG":"pci-0000_00_10_0-usb-0_2_1_0-scsi-0_0_0_0","ID_REVISION":"PMAP","ID_SERIAL":"Kingston_DataTraveler_3.0_E0D55E55CC73B541394A03E0-0:0","ID_SERIAL_SHORT":"E0D55E55CC73B541394A03E0","ID_TYPE":"disk","ID_USB_DRIVER":"usb-storage","ID_USB_INTERFACES":":080650:","ID_USB_INTERFACE_NUM":"00","ID_VENDOR":"Kingston","ID_VENDOR_ENC":"Kingston","ID_VENDOR_ID":"0951","MAJOR":"8","MINOR":"17","PARTN":"1","SEQNUM":"3046","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"35079291"} Apr 13 21:47:33 volumio sudo[13582]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sdb1 Apr 13 21:47:33 volumio sudo[13582]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 21:47:33 volumio systemd[1]: media-KINGSTON.mount: Succeeded. Apr 13 21:47:33 volumio sudo[13582]: pam_unix(sudo:session): session closed for user root Apr 13 21:47:37 volumio volumio[925]: info: TEST: Here we shall have deleted mounted folder: /mnt/USB/KINGSTON Apr 13 21:47:38 volumio volumio[925]: info: Scanning removed location : "USB/KINGSTON" Apr 13 21:47:38 volumio volumio[925]: verbose: ControllerMpd::sendMpdCommand status Apr 13 21:47:38 volumio volumio[925]: info: Apr 13 21:47:38 volumio volumio[925]: ---------------------------- MPD announces state update: update Apr 13 21:47:38 volumio volumio[925]: info: ControllerMpd::getState Apr 13 21:47:38 volumio volumio[925]: verbose: ControllerMpd::sendMpdCommand status Apr 13 21:47:38 volumio volumio[925]: info: MPD Database updated - AlbumList cache refreshed Apr 13 21:47:38 volumio volumio[925]: info: Apr 13 21:47:38 volumio volumio[925]: ---------------------------- MPD announces state update: database Apr 13 21:47:38 volumio volumio[925]: verbose: ControllerMpd::sendMpdCommand status Apr 13 21:47:38 volumio volumio[925]: info: Apr 13 21:47:38 volumio volumio[925]: ---------------------------- MPD announces state update: update Apr 13 21:47:38 volumio volumio[925]: info: ControllerMpd::getState Apr 13 21:47:38 volumio volumio[925]: verbose: ControllerMpd::sendMpdCommand status Apr 13 21:47:38 volumio volumio[925]: info: ControllerMpd::getState Apr 13 21:47:38 volumio volumio[925]: verbose: ControllerMpd::sendMpdCommand status Apr 13 21:47:38 volumio volumio[925]: info: sendMpdCommand status took 16 milliseconds Apr 13 21:47:38 volumio volumio[925]: info: sendMpdCommand status took 14 milliseconds Apr 13 21:47:38 volumio volumio[925]: verbose: ControllerMpd::parseState Apr 13 21:47:38 volumio volumio[925]: info: Command Router : Notfying DB Updatefalse Apr 13 21:47:38 volumio volumio[925]: info: CoreCommandRouter::Close All Modals sent Apr 13 21:47:38 volumio volumio[925]: verbose: ControllerMpd::parseState Apr 13 21:47:38 volumio volumio[925]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 13 21:47:38 volumio volumio[925]: info: sendMpdCommand status took 70 milliseconds Apr 13 21:47:38 volumio volumio[925]: info: sendMpdCommand status took 69 milliseconds Apr 13 21:47:38 volumio volumio[925]: info: sendMpdCommand status took 69 milliseconds Apr 13 21:47:38 volumio volumio[925]: verbose: ControllerMpd::parseState Apr 13 21:47:38 volumio volumio[925]: info: Command Router : Notfying DB Updatefalse Apr 13 21:47:38 volumio volumio[925]: info: CoreCommandRouter::Close All Modals sent Apr 13 21:47:38 volumio volumio[925]: verbose: ControllerMpd::parseState Apr 13 21:47:38 volumio volumio[925]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 13 21:47:38 volumio volumio[925]: verbose: ControllerMpd::parseState Apr 13 21:47:38 volumio volumio[925]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 13 21:47:38 volumio volumio[925]: info: sendMpdCommand playlistinfo took 58 milliseconds Apr 13 21:47:38 volumio volumio[925]: info: sendMpdCommand playlistinfo took 8 milliseconds Apr 13 21:47:38 volumio volumio[925]: info: sendMpdCommand playlistinfo took 8 milliseconds Apr 13 21:47:38 volumio volumio[925]: verbose: ControllerMpd::parseTrackInfo Apr 13 21:47:38 volumio volumio[925]: verbose: ControllerMpd::parseTrackInfo Apr 13 21:47:38 volumio volumio[925]: verbose: ControllerMpd::parseTrackInfo Apr 13 21:47:38 volumio volumio[925]: info: ControllerMpd::pushState Apr 13 21:47:38 volumio volumio[925]: info: CoreCommandRouter::servicePushState Apr 13 21:47:38 volumio volumio[925]: verbose: In UPNP mode Apr 13 21:47:38 volumio volumio[925]: verbose: STATE SERVICE {"status":"play","position":0,"seek":93592,"duration":337,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"705 Kbps","isStreaming":false,"title":"春江花月夜","artist":"赵聪","album":"聆听中国","uri":"http://192.168.31.142:41209/bridge-11.flac","trackType":"flac"} Apr 13 21:47:38 volumio volumio[925]: verbose: CURRENT POSITION 1 Apr 13 21:47:38 volumio volumio[925]: info: CoreStateMachine::syncState stateService play Apr 13 21:47:38 volumio volumio[925]: info: CoreStateMachine::syncState currentStatus play Apr 13 21:47:38 volumio volumio[925]: info: Received an update from plugin. extracting info from payload Apr 13 21:47:38 volumio volumio[925]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 13 21:47:38 volumio volumio[925]: info: CoreStateMachine::pushState Apr 13 21:47:38 volumio volumio[925]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 13 21:47:38 volumio volumio[925]: info: CoreCommandRouter::volumioPushState Apr 13 21:47:38 volumio volumio[925]: info: CoreStateMachine::pushState Apr 13 21:47:38 volumio volumio[925]: info: CoreCommandRouter::volumioPushState Apr 13 21:47:38 volumio volumio[925]: info: ControllerMpd::pushState Apr 13 21:47:38 volumio volumio[925]: info: CoreCommandRouter::servicePushState Apr 13 21:47:38 volumio volumio[925]: verbose: In UPNP mode Apr 13 21:47:38 volumio volumio[925]: verbose: STATE SERVICE {"status":"play","position":0,"seek":93592,"duration":337,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"705 Kbps","isStreaming":false,"title":"春江花月夜","artist":"赵聪","album":"聆听中国","uri":"http://192.168.31.142:41209/bridge-11.flac","trackType":"flac"} Apr 13 21:47:38 volumio volumio[925]: verbose: CURRENT POSITION 1 Apr 13 21:47:38 volumio volumio[925]: info: CoreStateMachine::syncState stateService play Apr 13 21:47:38 volumio volumio[925]: info: CoreStateMachine::syncState currentStatus play Apr 13 21:47:38 volumio volumio[925]: info: Received an update from plugin. extracting info from payload Apr 13 21:47:38 volumio volumio[925]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 13 21:47:38 volumio volumio[925]: info: CoreStateMachine::pushState Apr 13 21:47:38 volumio volumio[925]: info: CoreCommandRouter::volumioPushState Apr 13 21:47:38 volumio volumio[925]: info: CoreStateMachine::pushState Apr 13 21:47:38 volumio volumio[925]: info: CoreCommandRouter::volumioPushState Apr 13 21:47:38 volumio volumio[925]: info: ControllerMpd::pushState Apr 13 21:47:38 volumio volumio[925]: info: CoreCommandRouter::servicePushState Apr 13 21:47:38 volumio volumio[925]: verbose: In UPNP mode Apr 13 21:47:38 volumio volumio[925]: verbose: STATE SERVICE {"status":"play","position":0,"seek":93592,"duration":337,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"705 Kbps","isStreaming":false,"title":"春江花月夜","artist":"赵聪","album":"聆听中国","uri":"http://192.168.31.142:41209/bridge-11.flac","trackType":"flac"} Apr 13 21:47:38 volumio volumio[925]: verbose: CURRENT POSITION 1 Apr 13 21:47:38 volumio volumio[925]: info: CoreStateMachine::syncState stateService play Apr 13 21:47:38 volumio volumio[925]: info: CoreStateMachine::syncState currentStatus play Apr 13 21:47:38 volumio volumio[925]: info: Received an update from plugin. extracting info from payload Apr 13 21:47:38 volumio volumio[925]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 13 21:47:38 volumio volumio[925]: info: CoreStateMachine::pushState Apr 13 21:47:38 volumio volumio[925]: info: CoreCommandRouter::volumioPushState Apr 13 21:47:38 volumio volumio[925]: info: CoreStateMachine::pushState Apr 13 21:47:38 volumio volumio[925]: info: CoreCommandRouter::volumioPushState Apr 13 21:47:38 volumio volumio[925]: info: ------------------------------ 178ms Apr 13 21:47:38 volumio volumio[925]: info: ------------------------------ 165ms Apr 13 21:47:38 volumio volumio[925]: info: ------------------------------ 166ms Apr 13 21:47:38 volumio volumio[925]: info: CoreCommandRouter::volumioGetQueue Apr 13 21:47:38 volumio volumio[925]: info: CoreStateMachine::getQueue Apr 13 21:47:38 volumio volumio[925]: info: CorePlayQueue::getQueue Apr 13 21:47:38 volumio volumio[925]: info: CoreCommandRouter::volumioGetQueue Apr 13 21:47:38 volumio volumio[925]: info: CoreStateMachine::getQueue Apr 13 21:47:38 volumio volumio[925]: info: CorePlayQueue::getQueue Apr 13 21:47:38 volumio volumio[925]: info: CoreCommandRouter::volumioGetQueue Apr 13 21:47:38 volumio volumio[925]: info: CoreStateMachine::getQueue Apr 13 21:47:38 volumio volumio[925]: info: CorePlayQueue::getQueue Apr 13 21:47:38 volumio volumio[925]: info: CoreCommandRouter::volumioGetQueue Apr 13 21:47:38 volumio volumio[925]: info: CoreStateMachine::getQueue Apr 13 21:47:38 volumio volumio[925]: info: CorePlayQueue::getQueue Apr 13 21:47:38 volumio volumio[925]: info: CoreCommandRouter::volumioGetQueue Apr 13 21:47:38 volumio volumio[925]: info: CoreStateMachine::getQueue Apr 13 21:47:38 volumio volumio[925]: info: CorePlayQueue::getQueue Apr 13 21:47:38 volumio volumio[925]: info: CoreCommandRouter::volumioGetQueue Apr 13 21:47:38 volumio volumio[925]: info: CoreStateMachine::getQueue Apr 13 21:47:38 volumio volumio[925]: info: CorePlayQueue::getQueue Apr 13 21:48:00 volumio volumio[925]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 13 21:48:00 volumio volumio[925]: info: CURURI: music-library/USB/KINGSTON/惠威试音天碟CD5 Apr 13 21:48:00 volumio volumio[925]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Apr 13 21:48:00 volumio volumio[925]: info: Preload queue cleared Apr 13 21:48:02 volumio volumio[925]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 13 21:48:02 volumio volumio[925]: info: CURURI: music-library/USB/KINGSTON/惠威试音天碟CD5 Apr 13 21:48:02 volumio volumio[925]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Apr 13 21:48:03 volumio volumio[925]: info: Preload queue cleared Apr 13 21:48:07 volumio volumio[925]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 13 21:48:07 volumio volumio[925]: info: CURURI: music-library/USB/KINGSTON/惠威试音天碟CD4 Apr 13 21:48:07 volumio volumio[925]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Apr 13 21:48:07 volumio volumio[925]: info: Preload queue cleared Apr 13 21:48:15 volumio volumio[925]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 13 21:48:15 volumio volumio[925]: info: CURURI: music-library/USB/KINGSTON/赵聪《聆听中国-月舞》[SACD-DSF单轨]DXD正版 Apr 13 21:48:15 volumio volumio[925]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Apr 13 21:48:15 volumio volumio[925]: info: Preload queue cleared Apr 13 21:48:20 volumio volumio[925]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 13 21:48:20 volumio volumio[925]: Error: connect ETIMEDOUT 202.160.128.14:443 Apr 13 21:48:20 volumio volumio[925]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Apr 13 21:48:20 volumio volumio[925]: errno: -110, Apr 13 21:48:20 volumio volumio[925]: code: 'ETIMEDOUT', Apr 13 21:48:20 volumio volumio[925]: syscall: 'connect', Apr 13 21:48:20 volumio volumio[925]: address: '202.160.128.14', Apr 13 21:48:20 volumio volumio[925]: port: 443 Apr 13 21:48:20 volumio volumio[925]: } Apr 13 21:48:20 volumio volumio[925]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 13 21:48:20 volumio sudo[13875]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-13 21:47 Apr 13 21:48:20 volumio sudo[13875]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="a01a833dd28483f88cb390596f5090b7187992af" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 27 Feb 2025 12:15:38 PM CET" VOLUMIO_VERSION="3.795" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="9e0e048b157c8fb0f19240808f3da58b"