-- Logs begin at Sun 2025-06-29 13:12:23 +07, end at Wed 2025-07-02 20:07:32 +07. -- Jul 02 20:06:00 volumio9 ntpd[786]: Soliciting pool server 202.12.97.45 Jul 02 20:06:00 volumio9 ntpd[786]: Soliciting pool server 122.155.180.231 Jul 02 20:06:00 volumio9 ntpd[786]: Soliciting pool server 202.80.227.130 Jul 02 20:06:01 volumio9 volumio[821]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 02 20:06:01 volumio9 volumio[821]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 02 20:06:01 volumio9 volumio[821]: info: Discovery: Getting this device information Jul 02 20:06:01 volumio9 volumio[821]: info: CoreCommandRouter::volumioGetState Jul 02 20:06:01 volumio9 volumio[821]: info: CorePlayQueue::getTrack 0 Jul 02 20:06:01 volumio9 volumio[821]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 02 20:06:01 volumio9 ntpd[786]: Soliciting pool server 147.50.17.138 Jul 02 20:06:05 volumio9 go-librespot[1153]: time="2025-07-02T20:06:05+07:00" level=trace msg="sent dealer ping" Jul 02 20:06:05 volumio9 go-librespot[1153]: time="2025-07-02T20:06:05+07:00" level=trace msg="received dealer pong" Jul 02 20:06:06 volumio9 ntpd[786]: receive: Unexpected origin timestamp 0xec0fad3d.d3ce5096 does not match aorg 0000000000.00000000 from server@202.28.92.208 xmt 0xec0fad3e.52bb31d5 Jul 02 20:06:06 volumio9 ntpd[786]: receive: Unexpected origin timestamp 0xec0fad3d.d3cbbab9 does not match aorg 0000000000.00000000 from server@202.29.58.130 xmt 0xec0fad3e.530f1b45 Jul 02 20:06:17 volumio9 kernel: usb 1-1.1: USB disconnect, device number 14 Jul 02 20:06:17 volumio9 volumio[821]: info: Jul 02 20:06:17 volumio9 volumio[821]: ---------------------------- USB Audio Device Detached Jul 02 20:06:17 volumio9 volumio[821]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Jul 02 20:06:17 volumio9 volumio[821]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 02 20:06:18 volumio9 kernel: usb 1-1.1: new high-speed USB device number 15 using xhci_hcd Jul 02 20:06:18 volumio9 kernel: usb 1-1.1: New USB device found, idVendor=152a, idProduct=85dd, bcdDevice= 3.53 Jul 02 20:06:18 volumio9 kernel: usb 1-1.1: New USB device strings: Mfr=1, Product=3, SerialNumber=2 Jul 02 20:06:18 volumio9 kernel: usb 1-1.1: Product: SMSL USB AUDIO Jul 02 20:06:18 volumio9 kernel: usb 1-1.1: Manufacturer: SMSL Jul 02 20:06:18 volumio9 kernel: usb 1-1.1: 1:3 : unsupported format bits 0x100000000 Jul 02 20:06:18 volumio9 kernel: hid-generic 0003:152A:85DD.0008: hiddev96,hidraw0: USB HID v1.10 Device [SMSL SMSL USB AUDIO] on usb-0000:01:00.0-1.1/input3 Jul 02 20:06:18 volumio9 volumio[821]: info: Jul 02 20:06:18 volumio9 volumio[821]: ---------------------------- USB Audio Device Attached Jul 02 20:06:18 volumio9 volumio[821]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Jul 02 20:06:25 volumio9 kernel: usb 1-1.1: USB disconnect, device number 15 Jul 02 20:06:26 volumio9 volumio[821]: info: Jul 02 20:06:26 volumio9 volumio[821]: ---------------------------- USB Audio Device Detached Jul 02 20:06:26 volumio9 volumio[821]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Jul 02 20:06:26 volumio9 volumio[821]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 02 20:06:26 volumio9 kernel: usb 1-1.1: new high-speed USB device number 16 using xhci_hcd Jul 02 20:06:26 volumio9 kernel: usb 1-1.1: New USB device found, idVendor=152a, idProduct=85dd, bcdDevice= 3.53 Jul 02 20:06:26 volumio9 kernel: usb 1-1.1: New USB device strings: Mfr=1, Product=3, SerialNumber=2 Jul 02 20:06:26 volumio9 kernel: usb 1-1.1: Product: SMSL USB AUDIO Jul 02 20:06:26 volumio9 kernel: usb 1-1.1: Manufacturer: SMSL Jul 02 20:06:26 volumio9 kernel: usb 1-1.1: 1:3 : unsupported format bits 0x100000000 Jul 02 20:06:26 volumio9 kernel: hid-generic 0003:152A:85DD.0009: hiddev96,hidraw0: USB HID v1.10 Device [SMSL SMSL USB AUDIO] on usb-0000:01:00.0-1.1/input3 Jul 02 20:06:26 volumio9 volumio[821]: info: Jul 02 20:06:26 volumio9 volumio[821]: ---------------------------- USB Audio Device Attached Jul 02 20:06:26 volumio9 volumio[821]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Jul 02 20:06:31 volumio9 volumio[821]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 02 20:06:31 volumio9 volumio[821]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 02 20:06:31 volumio9 volumio[821]: info: Discovery: Getting this device information Jul 02 20:06:31 volumio9 volumio[821]: info: CoreCommandRouter::volumioGetState Jul 02 20:06:31 volumio9 volumio[821]: info: CorePlayQueue::getTrack 0 Jul 02 20:06:31 volumio9 volumio[821]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 02 20:06:36 volumio9 go-librespot[1153]: time="2025-07-02T20:06:36+07:00" level=trace msg="sent dealer ping" Jul 02 20:06:36 volumio9 go-librespot[1153]: time="2025-07-02T20:06:36+07:00" level=trace msg="received dealer pong" Jul 02 20:06:51 volumio9 kernel: usb 1-1.1: USB disconnect, device number 16 Jul 02 20:06:51 volumio9 volumio[821]: info: Jul 02 20:06:51 volumio9 volumio[821]: ---------------------------- USB Audio Device Detached Jul 02 20:06:51 volumio9 volumio[821]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Jul 02 20:06:51 volumio9 volumio[821]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 02 20:06:51 volumio9 kernel: usb 1-1.1: new high-speed USB device number 17 using xhci_hcd Jul 02 20:06:52 volumio9 kernel: usb 1-1.1: New USB device found, idVendor=152a, idProduct=85dd, bcdDevice= 3.53 Jul 02 20:06:52 volumio9 kernel: usb 1-1.1: New USB device strings: Mfr=1, Product=3, SerialNumber=2 Jul 02 20:06:52 volumio9 kernel: usb 1-1.1: Product: SMSL USB AUDIO Jul 02 20:06:52 volumio9 kernel: usb 1-1.1: Manufacturer: SMSL Jul 02 20:06:52 volumio9 kernel: usb 1-1.1: 1:3 : unsupported format bits 0x100000000 Jul 02 20:06:52 volumio9 kernel: hid-generic 0003:152A:85DD.000A: hiddev96,hidraw0: USB HID v1.10 Device [SMSL SMSL USB AUDIO] on usb-0000:01:00.0-1.1/input3 Jul 02 20:06:52 volumio9 volumio[821]: info: Jul 02 20:06:52 volumio9 volumio[821]: ---------------------------- USB Audio Device Attached Jul 02 20:06:52 volumio9 volumio[821]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Jul 02 20:06:59 volumio9 volumio[821]: info: CoreCommandRouter::volumioGetQueue Jul 02 20:06:59 volumio9 volumio[821]: info: CoreStateMachine::getQueue Jul 02 20:06:59 volumio9 volumio[821]: info: CorePlayQueue::getQueue Jul 02 20:07:00 volumio9 volumio[821]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 02 20:07:00 volumio9 volumio[821]: info: CURURI: music-library Jul 02 20:07:00 volumio9 volumio[821]: error: Failed LSINFO: null Jul 02 20:07:00 volumio9 volumio[821]: info: Preload queue cleared Jul 02 20:07:01 volumio9 volumio[821]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 02 20:07:01 volumio9 volumio[821]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 02 20:07:01 volumio9 volumio[821]: info: Discovery: Getting this device information Jul 02 20:07:01 volumio9 volumio[821]: info: CoreCommandRouter::volumioGetState Jul 02 20:07:01 volumio9 volumio[821]: info: CorePlayQueue::getTrack 0 Jul 02 20:07:01 volumio9 volumio[821]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 02 20:07:04 volumio9 volumio[821]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jul 02 20:07:04 volumio9 volumio[821]: info: Preload queue cleared Jul 02 20:07:05 volumio9 go-librespot[1153]: time="2025-07-02T20:07:05+07:00" level=trace msg="received accesspoint ping" Jul 02 20:07:05 volumio9 go-librespot[1153]: time="2025-07-02T20:07:05+07:00" level=trace msg="received accesspoint pong ack" Jul 02 20:07:06 volumio9 go-librespot[1153]: time="2025-07-02T20:07:06+07:00" level=trace msg="sent dealer ping" Jul 02 20:07:06 volumio9 go-librespot[1153]: time="2025-07-02T20:07:06+07:00" level=trace msg="received dealer pong" Jul 02 20:07:08 volumio9 volumio[821]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jul 02 20:07:08 volumio9 volumio[821]: info: Preload queue cleared Jul 02 20:07:14 volumio9 volumio[821]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 02 20:07:14 volumio9 volumio[821]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 02 20:07:14 volumio9 volumio[821]: info: Retrieving Cloud Streaming UI Jul 02 20:07:14 volumio9 volumio[821]: info: Getting Tidal Cloud Configuration Jul 02 20:07:14 volumio9 volumio[821]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 02 20:07:14 volumio9 volumio[821]: info: Getting Qobuz Cloud Configuration Jul 02 20:07:14 volumio9 volumio[821]: info: Asking plugin for UI Config Jul 02 20:07:14 volumio9 volumio[821]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 02 20:07:14 volumio9 volumio[821]: info: Getting Spotify Cloud Configuration Jul 02 20:07:14 volumio9 volumio[821]: info: Asking plugin for UI Config Jul 02 20:07:14 volumio9 volumio[821]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 02 20:07:14 volumio9 volumio[821]: info: Saving Spotify Acccount Jul 02 20:07:14 volumio9 volumio[821]: info: Got Tidal Cloud Configuration Jul 02 20:07:14 volumio9 volumio[821]: info: Got it Jul 02 20:07:14 volumio9 volumio[821]: info: Got it Jul 02 20:07:14 volumio9 volumio[821]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jul 02 20:07:14 volumio9 volumio[821]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 02 20:07:14 volumio9 volumio[821]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Jul 02 20:07:14 volumio9 volumio[821]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 02 20:07:14 volumio9 volumio[821]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 02 20:07:14 volumio9 volumio[821]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 02 20:07:14 volumio9 volumio[821]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 02 20:07:14 volumio9 volumio[821]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 02 20:07:14 volumio9 volumio[821]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 02 20:07:14 volumio9 volumio[821]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 02 20:07:14 volumio9 volumio[821]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 02 20:07:14 volumio9 volumio[821]: info: CoreCommandRouter::volumioGetBrowseSources Jul 02 20:07:14 volumio9 volumio[821]: info: CoreCommandRouter::volumioGetBrowseSources Jul 02 20:07:14 volumio9 volumio[821]: info: CoreCommandRouter::volumioGetBrowseSources Jul 02 20:07:14 volumio9 volumio[821]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 02 20:07:15 volumio9 volumio[821]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jul 02 20:07:18 volumio9 volumio[821]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 02 20:07:22 volumio9 volumio[821]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 02 20:07:25 volumio9 volumio[821]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare Jul 02 20:07:26 volumio9 volumio[821]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jul 02 20:07:26 volumio9 sudo[1253]: pam_unix(sudo:session): session closed for user root Jul 02 20:07:26 volumio9 volumio[821]: info: Cannot mount NAS Hires_Music at system boot, trial number 2 ,retrying in 5 seconds Jul 02 20:07:26 volumio9 volumio[821]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 02 20:07:28 volumio9 volumio[821]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare Jul 02 20:07:29 volumio9 volumio[821]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jul 02 20:07:30 volumio9 volumio[821]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 02 20:07:31 volumio9 volumio[821]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 02 20:07:31 volumio9 volumio[821]: TypeError: Cannot read property 'replace' of undefined Jul 02 20:07:31 volumio9 volumio[821]: at ControllerNetworkfs.mountShare (/volumio/app/plugins/system_controller/networkfs/index.js:202:28) Jul 02 20:07:31 volumio9 volumio[821]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/networkfs/index.js:255:20) Jul 02 20:07:31 volumio9 volumio[821]: at listOnTimeout (internal/timers.js:554:17) Jul 02 20:07:31 volumio9 volumio[821]: at processTimers (internal/timers.js:497:7) Jul 02 20:07:31 volumio9 volumio[821]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 02 20:07:32 volumio9 sudo[2562]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-02 20:06 Jul 02 20:07:32 volumio9 sudo[2562]: 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="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 10 Jun 2025 04:52:53 PM CEST" VOLUMIO_VERSION="3.816" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="a72866a0de4045751d03a035de6290e1"