-- Logs begin at Sun 2025-03-09 12:06:38 CST, end at Sun 2025-03-09 12:30:43 CST. -- Mar 09 12:29:02 volumio volumio[5644]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 09 12:29:02 volumio volumio[5644]: info: CURURI: artists://%E5%88%98%E7%B4%AB%E7%8E%B2 Mar 09 12:29:02 volumio volumio[5644]: info: Preload queue cleared Mar 09 12:29:02 volumio volumio[5644]: info: Preload queue cleared Mar 09 12:29:02 volumio volumio[5644]: info: Preloading song: music-library/NAS/内置盘30g/u盘试机/群星-花好月圆.ape Mar 09 12:29:03 volumio volumio[5644]: info: Exploding uri music-library/NAS/内置盘30g/u盘试机/群星-花好月圆.ape in service mpd Mar 09 12:29:03 volumio volumio[5644]: info: ALBUMART /albumart?cacheid=627&web=%E5%88%98%E7%B4%AB%E7%8E%B2/%E5%90%8D%E6%AD%8C%E7%BA%A2%20%E5%8F%81/extralarge&path=%2Fmnt%2FNAS%2F%E5%86%85%E7%BD%AE%E7%9B%9830g%2Fu%E7%9B%98%E8%AF%95%E6%9C%BA%2F%E7%BE%A4%E6%98%9F-%E8%8A%B1%E5%A5%BD%E6%9C%88%E5%9C%86.ape&metadata=false Mar 09 12:29:03 volumio volumio[5644]: info: URI /mnt/NAS/内置盘30g/u盘试机/群星-花好月圆.ape Mar 09 12:29:04 volumio volumio[5644]: info: No valid Plugin REST Endpoint Mar 09 12:29:09 volumio sudo[6424]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 09 12:29:09 volumio sudo[6424]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 09 12:29:09 volumio sudo[6424]: pam_unix(sudo:session): session closed for user root Mar 09 12:29:09 volumio sudo[6427]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 09 12:29:09 volumio sudo[6427]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 09 12:29:09 volumio sudo[6427]: pam_unix(sudo:session): session closed for user root Mar 09 12:29:10 volumio sudo[6434]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 09 12:29:10 volumio sudo[6434]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 09 12:29:10 volumio sudo[6434]: pam_unix(sudo:session): session closed for user root Mar 09 12:29:10 volumio sudo[6437]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 09 12:29:10 volumio sudo[6437]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 09 12:29:10 volumio sudo[6437]: pam_unix(sudo:session): session closed for user root Mar 09 12:29:27 volumio volumio[5644]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 09 12:29:27 volumio volumio[5644]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 09 12:29:27 volumio volumio[5644]: info: Discovery: Getting this device information Mar 09 12:29:27 volumio volumio[5644]: info: CoreCommandRouter::volumioGetState Mar 09 12:29:27 volumio volumio[5644]: info: CorePlayQueue::getTrack 1 Mar 09 12:29:27 volumio volumio[5644]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 09 12:29:41 volumio volumio[5644]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 09 12:29:41 volumio volumio[5644]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 09 12:29:41 volumio volumio[5644]: info: Discovery: Getting this device information Mar 09 12:29:41 volumio volumio[5644]: info: CoreCommandRouter::volumioGetState Mar 09 12:29:41 volumio volumio[5644]: info: CorePlayQueue::getTrack 1 Mar 09 12:29:41 volumio volumio[5644]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 09 12:29:41 volumio volumio[5644]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 09 12:29:41 volumio volumio[5644]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 09 12:29:41 volumio volumio[5644]: info: Discovery: Getting this device information Mar 09 12:29:41 volumio volumio[5644]: info: CoreCommandRouter::volumioGetState Mar 09 12:29:41 volumio volumio[5644]: info: CorePlayQueue::getTrack 1 Mar 09 12:29:41 volumio volumio[5644]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 09 12:29:41 volumio volumio[5644]: verbose: New Socket.io Connection to 192.168.1.28:3000 from 192.168.1.17 UA: Dart/3.5 (dart:io) Total Clients: 3 Mar 09 12:29:41 volumio volumio[5644]: info: CoreCommandRouter::volumioGetState Mar 09 12:29:41 volumio volumio[5644]: info: CorePlayQueue::getTrack 1 Mar 09 12:29:41 volumio volumio[5644]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 09 12:29:41 volumio volumio[5644]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 09 12:29:55 volumio volumio[5644]: Upnp client error: Error: This socket has been ended by the other party Mar 09 12:29:55 volumio volumio[5644]: Upnp client error: Error: This socket has been ended by the other party Mar 09 12:29:55 volumio volumio[5644]: Upnp client error: Error: This socket has been ended by the other party Mar 09 12:29:55 volumio volumio[5644]: Upnp client error: Error: This socket has been ended by the other party Mar 09 12:29:55 volumio volumio[5644]: Upnp client error: Error: This socket has been ended by the other party Mar 09 12:29:56 volumio sudo[6553]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 09 12:29:56 volumio sudo[6553]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 09 12:29:56 volumio sudo[6553]: pam_unix(sudo:session): session closed for user root Mar 09 12:29:56 volumio sudo[6556]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 09 12:29:56 volumio sudo[6556]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 09 12:29:56 volumio sudo[6556]: pam_unix(sudo:session): session closed for user root Mar 09 12:29:56 volumio volumio[5644]: verbose: New Socket.io Connection to 192.168.1.28 from 192.168.1.17 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_3_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Total Clients: 4 Mar 09 12:29:56 volumio volumio[5644]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 09 12:29:56 volumio sudo[6559]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 09 12:29:56 volumio sudo[6559]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 09 12:29:56 volumio sudo[6559]: pam_unix(sudo:session): session closed for user root Mar 09 12:29:56 volumio sudo[6562]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 09 12:29:56 volumio sudo[6562]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 09 12:29:56 volumio sudo[6562]: pam_unix(sudo:session): session closed for user root Mar 09 12:29:56 volumio volumio[5644]: verbose: New Socket.io Connection to 192.168.1.28 from 192.168.1.17 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_3_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Total Clients: 5 Mar 09 12:29:56 volumio volumio[5644]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 09 12:29:56 volumio volumio[5644]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 09 12:29:56 volumio volumio[5644]: info: CoreCommandRouter::volumioGetVisibleSources Mar 09 12:29:56 volumio volumio[5644]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 09 12:29:56 volumio volumio[5644]: info: CoreCommandRouter::volumioGetState Mar 09 12:29:56 volumio volumio[5644]: info: CorePlayQueue::getTrack 1 Mar 09 12:29:56 volumio volumio[5644]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 09 12:29:56 volumio volumio[5644]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 09 12:29:56 volumio volumio[5644]: info: Received Get System Info Mar 09 12:29:56 volumio volumio[5644]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 09 12:29:56 volumio volumio[5644]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 09 12:29:56 volumio volumio[5644]: info: Discovery: Getting this device information Mar 09 12:29:56 volumio volumio[5644]: info: CoreCommandRouter::volumioGetState Mar 09 12:29:56 volumio volumio[5644]: info: CorePlayQueue::getTrack 1 Mar 09 12:29:56 volumio volumio[5644]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 09 12:29:56 volumio volumio[5644]: info: CoreCommandRouter::volumioGetState Mar 09 12:29:56 volumio volumio[5644]: info: CorePlayQueue::getTrack 1 Mar 09 12:29:56 volumio volumio[5644]: info: Listing playlists Mar 09 12:29:56 volumio volumio[5644]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Mar 09 12:29:56 volumio volumio[5644]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 09 12:30:11 volumio kernel: usb 2-2: new SuperSpeed USB device number 2 using xhci_hcd Mar 09 12:30:11 volumio kernel: usb 2-2: New USB device found, idVendor=2537, idProduct=1068, bcdDevice= 1.00 Mar 09 12:30:11 volumio kernel: usb 2-2: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Mar 09 12:30:11 volumio kernel: usb 2-2: Product: SSK Storage Mar 09 12:30:11 volumio kernel: usb 2-2: Manufacturer: SSK Mar 09 12:30:11 volumio kernel: usb 2-2: SerialNumber: 0123456789ABCDE Mar 09 12:30:11 volumio kernel: usb-storage 2-2:1.0: USB Mass Storage device detected Mar 09 12:30:11 volumio kernel: usb-storage 2-2:1.0: Quirks match for vid 2537 pid 1068: 800000 Mar 09 12:30:11 volumio kernel: scsi host4: usb-storage 2-2:1.0 Mar 09 12:30:14 volumio kernel: scsi 4:0:0:0: Direct-Access SSK SSK BBF0 PQ: 0 ANSI: 6 Mar 09 12:30:14 volumio kernel: sd 4:0:0:0: Attached scsi generic sg3 type 0 Mar 09 12:30:14 volumio kernel: sd 4:0:0:0: [sdc] 234441648 512-byte logical blocks: (120 GB/112 GiB) Mar 09 12:30:14 volumio kernel: sd 4:0:0:0: [sdc] Write Protect is off Mar 09 12:30:14 volumio kernel: sd 4:0:0:0: [sdc] Mode Sense: 43 00 00 00 Mar 09 12:30:14 volumio kernel: sd 4:0:0:0: [sdc] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA Mar 09 12:30:14 volumio kernel: sdc: sdc1 sdc2 sdc3 sdc4 Mar 09 12:30:14 volumio kernel: sd 4:0:0:0: [sdc] Attached SCSI disk Mar 09 12:30:14 volumio volumio[5644]: info: Ignoring mount for partition: volumio Mar 09 12:30:14 volumio volumio[5644]: info: Mounting Device 0E4E-3857 Mar 09 12:30:14 volumio sudo[6618]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sdc4 /mnt/USB/0E4E-3857 -o noatime Mar 09 12:30:14 volumio sudo[6618]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 09 12:30:14 volumio sudo[6618]: pam_unix(sudo:session): session closed for user root Mar 09 12:30:14 volumio volumio[5644]: info: Ignoring mount for partition: volumio_data Mar 09 12:30:14 volumio volumio[5644]: info: Scanning new location : "USB/0E4E-3857" Mar 09 12:30:14 volumio volumio[5644]: info: Ignoring mount for partition: boot Mar 09 12:30:14 volumio volumio[5644]: verbose: ControllerMpd::sendMpdCommand status Mar 09 12:30:14 volumio volumio[5644]: info: Mar 09 12:30:14 volumio volumio[5644]: ---------------------------- MPD announces state update: update Mar 09 12:30:14 volumio volumio[5644]: info: ControllerMpd::getState Mar 09 12:30:14 volumio volumio[5644]: verbose: ControllerMpd::sendMpdCommand status Mar 09 12:30:14 volumio volumio[5644]: verbose: ControllerMpd::sendMpdCommand status Mar 09 12:30:14 volumio volumio[5644]: info: Mar 09 12:30:14 volumio volumio[5644]: ---------------------------- MPD announces state update: update Mar 09 12:30:14 volumio volumio[5644]: info: ControllerMpd::getState Mar 09 12:30:14 volumio volumio[5644]: verbose: ControllerMpd::sendMpdCommand status Mar 09 12:30:14 volumio volumio[5644]: verbose: ControllerMpd::sendMpdCommand status Mar 09 12:30:14 volumio volumio[5644]: info: Mar 09 12:30:14 volumio volumio[5644]: ---------------------------- MPD announces state update: update Mar 09 12:30:14 volumio volumio[5644]: info: ControllerMpd::getState Mar 09 12:30:14 volumio volumio[5644]: verbose: ControllerMpd::sendMpdCommand status Mar 09 12:30:14 volumio volumio[5644]: info: sendMpdCommand status took 1 milliseconds Mar 09 12:30:14 volumio volumio[5644]: info: sendMpdCommand status took 1 milliseconds Mar 09 12:30:14 volumio volumio[5644]: info: sendMpdCommand status took 1 milliseconds Mar 09 12:30:14 volumio volumio[5644]: info: sendMpdCommand status took 1 milliseconds Mar 09 12:30:14 volumio volumio[5644]: info: sendMpdCommand status took 0 milliseconds Mar 09 12:30:14 volumio volumio[5644]: info: sendMpdCommand status took 0 milliseconds Mar 09 12:30:14 volumio volumio[5644]: verbose: ControllerMpd::parseState Mar 09 12:30:14 volumio volumio[5644]: info: Command Router : Notfying DB Updatetrue Mar 09 12:30:14 volumio volumio[5644]: verbose: ControllerMpd::parseState Mar 09 12:30:14 volumio volumio[5644]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 12:30:14 volumio volumio[5644]: verbose: ControllerMpd::parseState Mar 09 12:30:14 volumio volumio[5644]: info: Command Router : Notfying DB Updatetrue Mar 09 12:30:14 volumio volumio[5644]: info: CoreCommandRouter::Close All Modals sent Mar 09 12:30:14 volumio volumio[5644]: verbose: ControllerMpd::parseState Mar 09 12:30:14 volumio volumio[5644]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 12:30:14 volumio volumio[5644]: verbose: ControllerMpd::parseState Mar 09 12:30:14 volumio volumio[5644]: info: Command Router : Notfying DB Updatetrue Mar 09 12:30:14 volumio volumio[5644]: info: CoreCommandRouter::Close All Modals sent Mar 09 12:30:14 volumio volumio[5644]: verbose: ControllerMpd::parseState Mar 09 12:30:14 volumio volumio[5644]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 12:30:14 volumio volumio[5644]: info: sendMpdCommand playlistinfo took 20 milliseconds Mar 09 12:30:14 volumio volumio[5644]: info: sendMpdCommand playlistinfo took 10 milliseconds Mar 09 12:30:14 volumio volumio[5644]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 09 12:30:14 volumio volumio[5644]: verbose: ControllerMpd::parseTrackInfo Mar 09 12:30:14 volumio volumio[5644]: verbose: ControllerMpd::parseTrackInfo Mar 09 12:30:14 volumio volumio[5644]: verbose: ControllerMpd::parseTrackInfo Mar 09 12:30:14 volumio volumio[5644]: info: ControllerMpd::pushState Mar 09 12:30:14 volumio volumio[5644]: info: CoreCommandRouter::servicePushState Mar 09 12:30:14 volumio volumio[5644]: info: CorePlayQueue::getTrack 1 Mar 09 12:30:14 volumio volumio[5644]: verbose: STATE SERVICE {"status":"play","position":0,"seek":199115,"duration":254,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"906 Kbps","isStreaming":false,"title":"Track 2","artist":"Unknown Artist","album":"Unknown Album (ripping started: 2025-01-08 11:00)","uri":"NAS/内置盘30g/CD人声测试2/02-Track_2.flac","trackType":"flac"} Mar 09 12:30:14 volumio volumio[5644]: verbose: CURRENT POSITION 1 Mar 09 12:30:14 volumio volumio[5644]: info: CoreStateMachine::syncState stateService play Mar 09 12:30:14 volumio volumio[5644]: info: CoreStateMachine::syncState currentStatus play Mar 09 12:30:14 volumio volumio[5644]: info: Received an update from plugin. extracting info from payload Mar 09 12:30:14 volumio volumio[5644]: info: CoreStateMachine::pushState Mar 09 12:30:14 volumio volumio[5644]: info: CorePlayQueue::getTrack 1 Mar 09 12:30:14 volumio volumio[5644]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 12:30:14 volumio volumio[5644]: info: CoreCommandRouter::volumioPushState Mar 09 12:30:14 volumio volumio[5644]: info: CoreStateMachine::pushState Mar 09 12:30:14 volumio volumio[5644]: info: CorePlayQueue::getTrack 1 Mar 09 12:30:14 volumio volumio[5644]: info: CoreCommandRouter::volumioPushState Mar 09 12:30:14 volumio volumio[5644]: info: ControllerMpd::pushState Mar 09 12:30:14 volumio volumio[5644]: info: CoreCommandRouter::servicePushState Mar 09 12:30:14 volumio volumio[5644]: info: CorePlayQueue::getTrack 1 Mar 09 12:30:14 volumio volumio[5644]: verbose: STATE SERVICE {"status":"play","position":0,"seek":199115,"duration":254,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"906 Kbps","isStreaming":false,"title":"Track 2","artist":"Unknown Artist","album":"Unknown Album (ripping started: 2025-01-08 11:00)","uri":"NAS/内置盘30g/CD人声测试2/02-Track_2.flac","trackType":"flac"} Mar 09 12:30:14 volumio volumio[5644]: verbose: CURRENT POSITION 1 Mar 09 12:30:14 volumio volumio[5644]: info: CoreStateMachine::syncState stateService play Mar 09 12:30:14 volumio volumio[5644]: info: CoreStateMachine::syncState currentStatus play Mar 09 12:30:14 volumio volumio[5644]: info: Received an update from plugin. extracting info from payload Mar 09 12:30:14 volumio volumio[5644]: info: CoreStateMachine::pushState Mar 09 12:30:14 volumio volumio[5644]: info: CorePlayQueue::getTrack 1 Mar 09 12:30:14 volumio volumio[5644]: info: CoreCommandRouter::volumioPushState Mar 09 12:30:14 volumio volumio[5644]: info: CoreStateMachine::pushState Mar 09 12:30:14 volumio volumio[5644]: info: CorePlayQueue::getTrack 1 Mar 09 12:30:14 volumio volumio[5644]: info: CoreCommandRouter::volumioPushState Mar 09 12:30:14 volumio volumio[5644]: info: ControllerMpd::pushState Mar 09 12:30:14 volumio volumio[5644]: info: CoreCommandRouter::servicePushState Mar 09 12:30:14 volumio volumio[5644]: info: CorePlayQueue::getTrack 1 Mar 09 12:30:14 volumio volumio[5644]: verbose: STATE SERVICE {"status":"play","position":0,"seek":199115,"duration":254,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"906 Kbps","isStreaming":false,"title":"Track 2","artist":"Unknown Artist","album":"Unknown Album (ripping started: 2025-01-08 11:00)","uri":"NAS/内置盘30g/CD人声测试2/02-Track_2.flac","trackType":"flac"} Mar 09 12:30:14 volumio volumio[5644]: verbose: CURRENT POSITION 1 Mar 09 12:30:14 volumio volumio[5644]: info: CoreStateMachine::syncState stateService play Mar 09 12:30:14 volumio volumio[5644]: info: CoreStateMachine::syncState currentStatus play Mar 09 12:30:14 volumio volumio[5644]: info: Received an update from plugin. extracting info from payload Mar 09 12:30:14 volumio volumio[5644]: info: CoreStateMachine::pushState Mar 09 12:30:14 volumio volumio[5644]: info: CorePlayQueue::getTrack 1 Mar 09 12:30:14 volumio volumio[5644]: info: CoreCommandRouter::volumioPushState Mar 09 12:30:14 volumio volumio[5644]: info: CoreStateMachine::pushState Mar 09 12:30:14 volumio volumio[5644]: info: CorePlayQueue::getTrack 1 Mar 09 12:30:14 volumio volumio[5644]: info: CoreCommandRouter::volumioPushState Mar 09 12:30:14 volumio volumio[5644]: info: ------------------------------ 45ms Mar 09 12:30:14 volumio volumio[5644]: info: ------------------------------ 45ms Mar 09 12:30:14 volumio volumio[5644]: info: ------------------------------ 46ms Mar 09 12:30:15 volumio volumio[5644]: info: MPD Database updated - AlbumList cache refreshed Mar 09 12:30:15 volumio volumio[5644]: info: Mar 09 12:30:15 volumio volumio[5644]: ---------------------------- MPD announces state update: database Mar 09 12:30:15 volumio volumio[5644]: verbose: ControllerMpd::sendMpdCommand status Mar 09 12:30:15 volumio volumio[5644]: info: Mar 09 12:30:15 volumio volumio[5644]: ---------------------------- MPD announces state update: update Mar 09 12:30:15 volumio volumio[5644]: info: ControllerMpd::getState Mar 09 12:30:15 volumio volumio[5644]: verbose: ControllerMpd::sendMpdCommand status Mar 09 12:30:15 volumio volumio[5644]: info: ControllerMpd::getState Mar 09 12:30:15 volumio volumio[5644]: verbose: ControllerMpd::sendMpdCommand status Mar 09 12:30:15 volumio volumio[5644]: info: MPD Database updated - AlbumList cache refreshed Mar 09 12:30:15 volumio volumio[5644]: info: Mar 09 12:30:15 volumio volumio[5644]: ---------------------------- MPD announces state update: database Mar 09 12:30:15 volumio volumio[5644]: verbose: ControllerMpd::sendMpdCommand status Mar 09 12:30:15 volumio volumio[5644]: info: Mar 09 12:30:15 volumio volumio[5644]: ---------------------------- MPD announces state update: update Mar 09 12:30:15 volumio volumio[5644]: info: ControllerMpd::getState Mar 09 12:30:15 volumio volumio[5644]: verbose: ControllerMpd::sendMpdCommand status Mar 09 12:30:15 volumio volumio[5644]: info: ControllerMpd::getState Mar 09 12:30:15 volumio volumio[5644]: verbose: ControllerMpd::sendMpdCommand status Mar 09 12:30:15 volumio volumio[5644]: info: MPD Database updated - AlbumList cache refreshed Mar 09 12:30:15 volumio volumio[5644]: info: Mar 09 12:30:15 volumio volumio[5644]: ---------------------------- MPD announces state update: database Mar 09 12:30:15 volumio volumio[5644]: verbose: ControllerMpd::sendMpdCommand status Mar 09 12:30:15 volumio volumio[5644]: info: Mar 09 12:30:15 volumio volumio[5644]: ---------------------------- MPD announces state update: update Mar 09 12:30:15 volumio volumio[5644]: info: ControllerMpd::getState Mar 09 12:30:15 volumio volumio[5644]: verbose: ControllerMpd::sendMpdCommand status Mar 09 12:30:15 volumio volumio[5644]: info: ControllerMpd::getState Mar 09 12:30:15 volumio volumio[5644]: verbose: ControllerMpd::sendMpdCommand status Mar 09 12:30:15 volumio volumio[5644]: info: sendMpdCommand status took 67 milliseconds Mar 09 12:30:15 volumio volumio[5644]: info: sendMpdCommand status took 68 milliseconds Mar 09 12:30:15 volumio volumio[5644]: verbose: ControllerMpd::parseState Mar 09 12:30:15 volumio volumio[5644]: info: Command Router : Notfying DB Updatefalse Mar 09 12:30:15 volumio volumio[5644]: info: CoreCommandRouter::Close All Modals sent Mar 09 12:30:15 volumio volumio[5644]: verbose: ControllerMpd::parseState Mar 09 12:30:15 volumio volumio[5644]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 12:30:15 volumio volumio[5644]: verbose: ControllerMpd::parseState Mar 09 12:30:15 volumio volumio[5644]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 12:30:15 volumio volumio[5644]: info: sendMpdCommand status took 121 milliseconds Mar 09 12:30:15 volumio volumio[5644]: info: sendMpdCommand status took 121 milliseconds Mar 09 12:30:15 volumio volumio[5644]: info: sendMpdCommand status took 121 milliseconds Mar 09 12:30:15 volumio volumio[5644]: verbose: ControllerMpd::parseState Mar 09 12:30:15 volumio volumio[5644]: info: Command Router : Notfying DB Updatefalse Mar 09 12:30:15 volumio volumio[5644]: info: CoreCommandRouter::Close All Modals sent Mar 09 12:30:15 volumio volumio[5644]: verbose: ControllerMpd::parseState Mar 09 12:30:15 volumio volumio[5644]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 12:30:15 volumio volumio[5644]: verbose: ControllerMpd::parseState Mar 09 12:30:15 volumio volumio[5644]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 12:30:15 volumio volumio[5644]: info: sendMpdCommand status took 163 milliseconds Mar 09 12:30:15 volumio volumio[5644]: info: sendMpdCommand status took 163 milliseconds Mar 09 12:30:15 volumio volumio[5644]: info: sendMpdCommand status took 163 milliseconds Mar 09 12:30:15 volumio volumio[5644]: info: sendMpdCommand playlistinfo took 76 milliseconds Mar 09 12:30:15 volumio volumio[5644]: info: sendMpdCommand playlistinfo took 76 milliseconds Mar 09 12:30:15 volumio volumio[5644]: info: sendMpdCommand playlistinfo took 32 milliseconds Mar 09 12:30:15 volumio volumio[5644]: info: sendMpdCommand playlistinfo took 32 milliseconds Mar 09 12:30:15 volumio volumio[5644]: verbose: ControllerMpd::parseState Mar 09 12:30:15 volumio volumio[5644]: info: Command Router : Notfying DB Updatefalse Mar 09 12:30:15 volumio volumio[5644]: info: CoreCommandRouter::Close All Modals sent Mar 09 12:30:15 volumio volumio[5644]: verbose: ControllerMpd::parseState Mar 09 12:30:15 volumio volumio[5644]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 12:30:15 volumio volumio[5644]: verbose: ControllerMpd::parseState Mar 09 12:30:15 volumio volumio[5644]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 12:30:15 volumio volumio[5644]: verbose: ControllerMpd::parseTrackInfo Mar 09 12:30:15 volumio volumio[5644]: verbose: ControllerMpd::parseTrackInfo Mar 09 12:30:15 volumio volumio[5644]: verbose: ControllerMpd::parseTrackInfo Mar 09 12:30:15 volumio volumio[5644]: verbose: ControllerMpd::parseTrackInfo Mar 09 12:30:15 volumio volumio[5644]: info: ControllerMpd::pushState Mar 09 12:30:15 volumio volumio[5644]: info: CoreCommandRouter::servicePushState Mar 09 12:30:15 volumio volumio[5644]: info: CorePlayQueue::getTrack 1 Mar 09 12:30:15 volumio volumio[5644]: verbose: STATE SERVICE {"status":"play","position":0,"seek":199866,"duration":254,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1069 Kbps","isStreaming":false,"title":"Track 2","artist":"Unknown Artist","album":"Unknown Album (ripping started: 2025-01-08 11:00)","uri":"NAS/内置盘30g/CD人声测试2/02-Track_2.flac","trackType":"flac"} Mar 09 12:30:15 volumio volumio[5644]: verbose: CURRENT POSITION 1 Mar 09 12:30:15 volumio volumio[5644]: info: CoreStateMachine::syncState stateService play Mar 09 12:30:15 volumio volumio[5644]: info: CoreStateMachine::syncState currentStatus play Mar 09 12:30:15 volumio volumio[5644]: info: Received an update from plugin. extracting info from payload Mar 09 12:30:15 volumio volumio[5644]: info: CoreStateMachine::pushState Mar 09 12:30:15 volumio volumio[5644]: info: CorePlayQueue::getTrack 1 Mar 09 12:30:15 volumio volumio[5644]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 12:30:15 volumio volumio[5644]: info: CoreCommandRouter::volumioPushState Mar 09 12:30:15 volumio volumio[5644]: info: CoreStateMachine::pushState Mar 09 12:30:15 volumio volumio[5644]: info: CorePlayQueue::getTrack 1 Mar 09 12:30:15 volumio volumio[5644]: info: CoreCommandRouter::volumioPushState Mar 09 12:30:15 volumio volumio[5644]: info: ControllerMpd::pushState Mar 09 12:30:15 volumio volumio[5644]: info: CoreCommandRouter::servicePushState Mar 09 12:30:15 volumio volumio[5644]: info: CorePlayQueue::getTrack 1 Mar 09 12:30:15 volumio volumio[5644]: verbose: STATE SERVICE {"status":"play","position":0,"seek":199866,"duration":254,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1069 Kbps","isStreaming":false,"title":"Track 2","artist":"Unknown Artist","album":"Unknown Album (ripping started: 2025-01-08 11:00)","uri":"NAS/内置盘30g/CD人声测试2/02-Track_2.flac","trackType":"flac"} Mar 09 12:30:15 volumio volumio[5644]: verbose: CURRENT POSITION 1 Mar 09 12:30:15 volumio volumio[5644]: info: CoreStateMachine::syncState stateService play Mar 09 12:30:15 volumio volumio[5644]: info: CoreStateMachine::syncState currentStatus play Mar 09 12:30:15 volumio volumio[5644]: info: Received an update from plugin. extracting info from payload Mar 09 12:30:15 volumio volumio[5644]: info: CoreStateMachine::pushState Mar 09 12:30:15 volumio volumio[5644]: info: CorePlayQueue::getTrack 1 Mar 09 12:30:15 volumio volumio[5644]: info: CoreCommandRouter::volumioPushState Mar 09 12:30:15 volumio volumio[5644]: info: CoreStateMachine::pushState Mar 09 12:30:15 volumio volumio[5644]: info: CorePlayQueue::getTrack 1 Mar 09 12:30:15 volumio volumio[5644]: info: CoreCommandRouter::volumioPushState Mar 09 12:30:15 volumio volumio[5644]: info: ControllerMpd::pushState Mar 09 12:30:15 volumio volumio[5644]: info: CoreCommandRouter::servicePushState Mar 09 12:30:15 volumio volumio[5644]: info: CorePlayQueue::getTrack 1 Mar 09 12:30:15 volumio volumio[5644]: verbose: STATE SERVICE {"status":"play","position":0,"seek":199866,"duration":254,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1069 Kbps","isStreaming":false,"title":"Track 2","artist":"Unknown Artist","album":"Unknown Album (ripping started: 2025-01-08 11:00)","uri":"NAS/内置盘30g/CD人声测试2/02-Track_2.flac","trackType":"flac"} Mar 09 12:30:15 volumio volumio[5644]: verbose: CURRENT POSITION 1 Mar 09 12:30:15 volumio volumio[5644]: info: CoreStateMachine::syncState stateService play Mar 09 12:30:15 volumio volumio[5644]: info: CoreStateMachine::syncState currentStatus play Mar 09 12:30:15 volumio volumio[5644]: info: Received an update from plugin. extracting info from payload Mar 09 12:30:15 volumio volumio[5644]: info: CoreStateMachine::pushState Mar 09 12:30:15 volumio volumio[5644]: info: CorePlayQueue::getTrack 1 Mar 09 12:30:15 volumio volumio[5644]: info: CoreCommandRouter::volumioPushState Mar 09 12:30:15 volumio volumio[5644]: info: CoreStateMachine::pushState Mar 09 12:30:15 volumio volumio[5644]: info: CorePlayQueue::getTrack 1 Mar 09 12:30:15 volumio volumio[5644]: info: CoreCommandRouter::volumioPushState Mar 09 12:30:15 volumio volumio[5644]: info: ControllerMpd::pushState Mar 09 12:30:15 volumio volumio[5644]: info: CoreCommandRouter::servicePushState Mar 09 12:30:15 volumio volumio[5644]: info: CorePlayQueue::getTrack 1 Mar 09 12:30:15 volumio volumio[5644]: verbose: STATE SERVICE {"status":"play","position":0,"seek":199866,"duration":254,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1069 Kbps","isStreaming":false,"title":"Track 2","artist":"Unknown Artist","album":"Unknown Album (ripping started: 2025-01-08 11:00)","uri":"NAS/内置盘30g/CD人声测试2/02-Track_2.flac","trackType":"flac"} Mar 09 12:30:15 volumio volumio[5644]: verbose: CURRENT POSITION 1 Mar 09 12:30:15 volumio volumio[5644]: info: CoreStateMachine::syncState stateService play Mar 09 12:30:15 volumio volumio[5644]: info: CoreStateMachine::syncState currentStatus play Mar 09 12:30:15 volumio volumio[5644]: info: Received an update from plugin. extracting info from payload Mar 09 12:30:15 volumio volumio[5644]: info: CoreStateMachine::pushState Mar 09 12:30:15 volumio volumio[5644]: info: CorePlayQueue::getTrack 1 Mar 09 12:30:15 volumio volumio[5644]: info: CoreCommandRouter::volumioPushState Mar 09 12:30:15 volumio volumio[5644]: info: CoreStateMachine::pushState Mar 09 12:30:15 volumio volumio[5644]: info: CorePlayQueue::getTrack 1 Mar 09 12:30:15 volumio volumio[5644]: info: CoreCommandRouter::volumioPushState Mar 09 12:30:15 volumio volumio[5644]: info: ------------------------------ 179ms Mar 09 12:30:15 volumio volumio[5644]: info: ------------------------------ 179ms Mar 09 12:30:15 volumio volumio[5644]: info: ------------------------------ 178ms Mar 09 12:30:15 volumio volumio[5644]: info: ------------------------------ 179ms Mar 09 12:30:15 volumio volumio[5644]: info: sendMpdCommand playlistinfo took 9 milliseconds Mar 09 12:30:15 volumio volumio[5644]: info: sendMpdCommand playlistinfo took 9 milliseconds Mar 09 12:30:15 volumio volumio[5644]: verbose: ControllerMpd::parseTrackInfo Mar 09 12:30:15 volumio volumio[5644]: verbose: ControllerMpd::parseTrackInfo Mar 09 12:30:15 volumio volumio[5644]: info: ControllerMpd::pushState Mar 09 12:30:15 volumio volumio[5644]: info: CoreCommandRouter::servicePushState Mar 09 12:30:15 volumio volumio[5644]: info: CorePlayQueue::getTrack 1 Mar 09 12:30:15 volumio volumio[5644]: verbose: STATE SERVICE {"status":"play","position":0,"seek":199866,"duration":254,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1069 Kbps","isStreaming":false,"title":"Track 2","artist":"Unknown Artist","album":"Unknown Album (ripping started: 2025-01-08 11:00)","uri":"NAS/内置盘30g/CD人声测试2/02-Track_2.flac","trackType":"flac"} Mar 09 12:30:15 volumio volumio[5644]: verbose: CURRENT POSITION 1 Mar 09 12:30:15 volumio volumio[5644]: info: CoreStateMachine::syncState stateService play Mar 09 12:30:15 volumio volumio[5644]: info: CoreStateMachine::syncState currentStatus play Mar 09 12:30:15 volumio volumio[5644]: info: Received an update from plugin. extracting info from payload Mar 09 12:30:15 volumio volumio[5644]: info: CoreStateMachine::pushState Mar 09 12:30:15 volumio volumio[5644]: info: CorePlayQueue::getTrack 1 Mar 09 12:30:15 volumio volumio[5644]: info: CoreCommandRouter::volumioPushState Mar 09 12:30:15 volumio volumio[5644]: info: CoreStateMachine::pushState Mar 09 12:30:15 volumio volumio[5644]: info: CorePlayQueue::getTrack 1 Mar 09 12:30:15 volumio volumio[5644]: info: CoreCommandRouter::volumioPushState Mar 09 12:30:15 volumio volumio[5644]: info: ControllerMpd::pushState Mar 09 12:30:15 volumio volumio[5644]: info: CoreCommandRouter::servicePushState Mar 09 12:30:15 volumio volumio[5644]: info: CorePlayQueue::getTrack 1 Mar 09 12:30:15 volumio volumio[5644]: verbose: STATE SERVICE {"status":"play","position":0,"seek":199866,"duration":254,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1069 Kbps","isStreaming":false,"title":"Track 2","artist":"Unknown Artist","album":"Unknown Album (ripping started: 2025-01-08 11:00)","uri":"NAS/内置盘30g/CD人声测试2/02-Track_2.flac","trackType":"flac"} Mar 09 12:30:15 volumio volumio[5644]: verbose: CURRENT POSITION 1 Mar 09 12:30:15 volumio volumio[5644]: info: CoreStateMachine::syncState stateService play Mar 09 12:30:15 volumio volumio[5644]: info: CoreStateMachine::syncState currentStatus play Mar 09 12:30:15 volumio volumio[5644]: info: Received an update from plugin. extracting info from payload Mar 09 12:30:15 volumio volumio[5644]: info: CoreStateMachine::pushState Mar 09 12:30:15 volumio volumio[5644]: info: CorePlayQueue::getTrack 1 Mar 09 12:30:15 volumio volumio[5644]: info: CoreCommandRouter::volumioPushState Mar 09 12:30:15 volumio volumio[5644]: info: CoreStateMachine::pushState Mar 09 12:30:15 volumio volumio[5644]: info: CorePlayQueue::getTrack 1 Mar 09 12:30:15 volumio volumio[5644]: info: CoreCommandRouter::volumioPushState Mar 09 12:30:15 volumio volumio[5644]: info: ------------------------------ 183ms Mar 09 12:30:15 volumio volumio[5644]: info: ------------------------------ 183ms Mar 09 12:30:19 volumio kernel: mmc0: card 0001 removed Mar 09 12:30:43 volumio volumio[5644]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 09 12:30:43 volumio volumio[5644]: Error: connect ETIMEDOUT 118.184.78.78:80 Mar 09 12:30:43 volumio volumio[5644]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Mar 09 12:30:43 volumio volumio[5644]: errno: -110, Mar 09 12:30:43 volumio volumio[5644]: code: 'ETIMEDOUT', Mar 09 12:30:43 volumio volumio[5644]: syscall: 'connect', Mar 09 12:30:43 volumio volumio[5644]: address: '118.184.78.78', Mar 09 12:30:43 volumio volumio[5644]: port: 80 Mar 09 12:30:43 volumio volumio[5644]: } Mar 09 12:30:43 volumio volumio[5644]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 09 12:30:43 volumio sudo[6757]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-09 12:29 Mar 09 12:30:43 volumio sudo[6757]: 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="e7445fab547cd22e23d9bef72406cfb610bc1d7d" VOLUMIO_FE_VERSION="5d5e99f8f803b3ec5fc5e8ca13bb4023600f3eee" VOLUMIO_FE3_VERSION="a6ae210575eae1ff43f06ab71e1cd17576840623" VOLUMIO_BE_VERSION="a9e1e1dd6072ffb15c0fcb8938d9ea0d8900c0da" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 24 Apr 2024 02:42:03 PM CEST" VOLUMIO_VERSION="3.661" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="c434411fe8754b648dc7feb1d8f43761"