-- Logs begin at Tue 2025-12-16 20:42:30 +07, end at Tue 2025-12-16 20:49:00 +07. --
Dec 16 20:48:16 volumio ntpd[1434]: Soliciting pool server 103.130.217.41
Dec 16 20:48:18 volumio ntpd[1434]: Soliciting pool server 2401:5b60:0:1::52
Dec 16 20:48:19 volumio kernel: usb 1-5: USB disconnect, device number 4
Dec 16 20:48:19 volumio volumio[1001]: info:
Dec 16 20:48:19 volumio volumio[1001]: ---------------------------- USB Audio Device Detached
Dec 16 20:48:19 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach
Dec 16 20:48:19 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Dec 16 20:48:19 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: raat , onStop
Dec 16 20:48:19 volumio ntpd[1434]: Soliciting pool server 103.221.223.143
Dec 16 20:48:19 volumio ntpd[1434]: Soliciting pool server 103.70.115.65
Dec 16 20:48:20 volumio kernel: usb 1-5: new high-speed USB device number 5 using xhci_hcd
Dec 16 20:48:20 volumio kernel: usb 1-5: New USB device found, idVendor=152a, idProduct=8750, bcdDevice= 1.65
Dec 16 20:48:20 volumio kernel: usb 1-5: New USB device strings: Mfr=1, Product=3, SerialNumber=2
Dec 16 20:48:20 volumio kernel: usb 1-5: Product: EX5
Dec 16 20:48:20 volumio kernel: usb 1-5: Manufacturer: Topping
Dec 16 20:48:20 volumio kernel: usb 1-5: 1:3 : unsupported format bits 0x100000000
Dec 16 20:48:20 volumio kernel: hid-generic 0003:152A:8750.0003: hiddev0,hidraw0: USB HID v1.10 Device [Topping EX5] on usb-0000:00:14.0-5/input3
Dec 16 20:48:20 volumio volumio[1001]: info:
Dec 16 20:48:20 volumio volumio[1001]: ---------------------------- USB Audio Device Attached
Dec 16 20:48:20 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach
Dec 16 20:48:20 volumio volumio[1001]: info: CoreCommandRouter::Close All Modals sent
Dec 16 20:48:20 volumio volumio[1001]: info: Preparing to save Alsa Options, stopping services first
Dec 16 20:48:20 volumio volumio[1001]: info: CoreCommandRouter::volumioGetState
Dec 16 20:48:20 volumio volumio[1001]: info: CoreCommandRouter::volumioPause
Dec 16 20:48:20 volumio volumio[1001]: info: CoreStateMachine::pause
Dec 16 20:48:20 volumio volumio[1001]: info: Saving Audio Output to: {"disallowPush":true,"output_device":{"value":"5","label":"EX5","alsacard":"EX5"},"i2s":false}
Dec 16 20:48:20 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Dec 16 20:48:20 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Dec 16 20:48:20 volumio volumio[1001]: info: Device 5 does not have any Mixer Control Available
Dec 16 20:48:20 volumio volumio[1001]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Dec 16 20:48:20 volumio volumio[1001]: info: Updating Volume Controller Parameters: Device: 5 Name: EX5 Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1
Dec 16 20:48:20 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume
Dec 16 20:48:20 volumio volumio[1001]: info: Disabling external Volume Control
Dec 16 20:48:20 volumio volumio[1001]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 16 20:48:20 volumio volumio[1001]: info: CoreStateMachine::pushState
Dec 16 20:48:20 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 16 20:48:20 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState
Dec 16 20:48:20 volumio volumio[1001]: info: Preparing to generate the ALSA configuration file
Dec 16 20:48:20 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Dec 16 20:48:20 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 16 20:48:20 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Dec 16 20:48:20 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 16 20:48:20 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 16 20:48:20 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 16 20:48:20 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 16 20:48:20 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 16 20:48:20 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 16 20:48:20 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 16 20:48:20 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Dec 16 20:48:20 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Dec 16 20:48:20 volumio volumio[1001]: info: Asound.conf file unchanged, so no further update is needed
Dec 16 20:48:20 volumio volumio[1001]: info: Output device has changed, restarting MPD
Dec 16 20:48:20 volumio sudo[2400]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Dec 16 20:48:20 volumio sudo[2400]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 16 20:48:20 volumio volumio[1001]: info: Output device has changed, restarting Shairport Sync
Dec 16 20:48:20 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 20:48:20 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 16 20:48:20 volumio sudo[2400]: pam_unix(sudo:session): session closed for user root
Dec 16 20:48:20 volumio sudo[2402]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Dec 16 20:48:20 volumio sudo[2402]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 16 20:48:20 volumio systemd[1]: Stopping Music Player Daemon...
Dec 16 20:48:20 volumio volumio[1001]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Dec 16 20:48:20 volumio volumio[1001]: info: MPD Permissions set
Dec 16 20:48:20 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 20:48:20 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 20:48:20 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 20:48:20 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 20:48:20 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 20:48:20 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 20:48:20 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 20:48:20 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 20:48:20 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=6/ABRT
Dec 16 20:48:20 volumio systemd[1]: mpd.service: Failed with result 'signal'.
Dec 16 20:48:20 volumio systemd[1]: Stopped Music Player Daemon.
Dec 16 20:48:20 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 16 20:48:20 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Dec 16 20:48:20 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 16 20:48:20 volumio systemd[1]: Starting Music Player Daemon...
Dec 16 20:48:20 volumio volumio[1001]: info: Starting Shairport Sync
Dec 16 20:48:20 volumio sudo[2416]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Dec 16 20:48:20 volumio sudo[2416]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 16 20:48:20 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Dec 16 20:48:20 volumio systemd[1]: shairport-sync.service: Succeeded.
Dec 16 20:48:20 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Dec 16 20:48:20 volumio sudo[2409]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Dec 16 20:48:20 volumio sudo[2409]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 16 20:48:20 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Dec 16 20:48:20 volumio sudo[2409]: pam_unix(sudo:session): session closed for user root
Dec 16 20:48:20 volumio sudo[2416]: pam_unix(sudo:session): session closed for user root
Dec 16 20:48:20 volumio volumio[1001]: info: Shairport-Sync Started
Dec 16 20:48:20 volumio mpd[2420]: Dec 16 20:48 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Dec 16 20:48:21 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat
Dec 16 20:48:21 volumio systemd[1]: Started Music Player Daemon.
Dec 16 20:48:21 volumio sudo[2402]: pam_unix(sudo:session): session closed for user root
Dec 16 20:48:21 volumio volumio[1001]: error: updateQueue error: null
Dec 16 20:48:24 volumio volumio[1001]: info: CoreCommandRouter::volumioRetrieveVolumeLevels
Dec 16 20:48:24 volumio volumio[1001]: info: CoreStateMachine::getcurrentVolume
Dec 16 20:48:24 volumio volumio[1001]: info: CoreCommandRouter::volumioRetrievevolume
Dec 16 20:48:24 volumio volumio[1001]: info: CoreStateMachine::pushState
Dec 16 20:48:24 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState
Dec 16 20:48:35 volumio volumio[1001]: error: error
Dec 16 20:48:47 volumio volumio[1001]: verbose: New Socket.io Connection to 192.168.1.17 from 192.168.1.11 UA: unknown Engine version: 3 Transport: websocket Total Clients: 4
Dec 16 20:48:47 volumio volumio[1001]: info: CoreCommandRouter::volumioGetState
Dec 16 20:48:47 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Dec 16 20:48:47 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Dec 16 20:48:47 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Dec 16 20:48:47 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Dec 16 20:48:47 volumio volumio[1001]: info: Discovery: Getting this device information
Dec 16 20:48:47 volumio volumio[1001]: info: CoreCommandRouter::volumioGetState
Dec 16 20:48:47 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Dec 16 20:48:50 volumio sudo[2497]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Dec 16 20:48:50 volumio sudo[2497]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 16 20:48:50 volumio sudo[2497]: pam_unix(sudo:session): session closed for user root
Dec 16 20:48:50 volumio sudo[2499]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Dec 16 20:48:50 volumio sudo[2499]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 16 20:48:50 volumio sudo[2499]: pam_unix(sudo:session): session closed for user root
Dec 16 20:48:50 volumio volumio[1001]: verbose: New Socket.io Connection to 192.168.1.17 from 192.168.1.11 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 16_3_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 5
Dec 16 20:48:50 volumio volumio[1001]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 16 20:48:50 volumio volumio[1001]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 16 20:48:50 volumio volumio[1001]: info: Retrieving Cloud Streaming UI
Dec 16 20:48:50 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Dec 16 20:48:50 volumio volumio[1001]: info: CoreCommandRouter::volumioGetState
Dec 16 20:48:50 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Dec 16 20:48:50 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Dec 16 20:48:50 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Dec 16 20:48:50 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Dec 16 20:48:50 volumio volumio[1001]: info: Getting Tidal Cloud Configuration
Dec 16 20:48:50 volumio volumio[1001]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 16 20:48:50 volumio volumio[1001]: info: Getting Qobuz Cloud Configuration
Dec 16 20:48:50 volumio volumio[1001]: info: Asking plugin for UI Config
Dec 16 20:48:50 volumio volumio[1001]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 16 20:48:50 volumio volumio[1001]: info: Getting Spotify Cloud Configuration
Dec 16 20:48:50 volumio volumio[1001]: info: Asking plugin for UI Config
Dec 16 20:48:50 volumio volumio[1001]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 16 20:48:50 volumio volumio[1001]: info: Saving Spotify Acccount
Dec 16 20:48:50 volumio volumio[1001]: info: Got Tidal Cloud Configuration
Dec 16 20:48:50 volumio volumio[1001]: info: Got it
Dec 16 20:48:50 volumio volumio[1001]: info: Got it
Dec 16 20:48:50 volumio volumio[1001]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Dec 16 20:48:50 volumio volumio[1001]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 16 20:48:50 volumio volumio[1001]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
Dec 16 20:48:50 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Dec 16 20:48:50 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Dec 16 20:48:50 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Dec 16 20:48:50 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Dec 16 20:48:50 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 16 20:48:50 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 16 20:48:50 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 16 20:48:50 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 16 20:48:50 volumio volumio[1001]: info: CoreCommandRouter::volumioGetBrowseSources
Dec 16 20:48:50 volumio volumio[1001]: info: CoreCommandRouter::volumioGetBrowseSources
Dec 16 20:48:50 volumio volumio[1001]: info: CoreCommandRouter::volumioGetBrowseSources
Dec 16 20:48:50 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 16 20:48:50 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Dec 16 20:48:54 volumio volumio[1001]: info: Disabling MyMusic plugin upnp
Dec 16 20:48:54 volumio sudo[2518]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service
Dec 16 20:48:54 volumio sudo[2518]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 16 20:48:54 volumio systemd[1]: Stopping UPnP Renderer front-end to MPD...
Dec 16 20:48:54 volumio volumio[1001]: error: Upnp client error: Error: This socket has been ended by the other party
Dec 16 20:48:54 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 16 20:48:58 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 16 20:49:00 volumio volumio[1001]: info: Enabling MyMusic plugin upnp
Dec 16 20:49:00 volumio volumio[1001]: info: Enabling plugin upnp
Dec 16 20:49:00 volumio volumio[1001]: info: Loading plugin "upnp"...
Dec 16 20:49:00 volumio volumio[1001]: info: [1765892940093] Starting Upmpd Daemon
Dec 16 20:49:00 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Dec 16 20:49:00 volumio volumio[1001]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 16 20:49:00 volumio volumio[1001]: Error: listen EADDRINUSE: address already in use :::6599
Dec 16 20:49:00 volumio volumio[1001]: at Server.setupListenHandle [as _listen2] (net.js:1331:16)
Dec 16 20:49:00 volumio volumio[1001]: at listenInCluster (net.js:1379:12)
Dec 16 20:49:00 volumio volumio[1001]: at Server.listen (net.js:1465:7)
Dec 16 20:49:00 volumio volumio[1001]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17)
Dec 16 20:49:00 volumio volumio[1001]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38)
Dec 16 20:49:00 volumio volumio[1001]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19)
Dec 16 20:49:00 volumio volumio[1001]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28)
Dec 16 20:49:00 volumio volumio[1001]: at processTicksAndRejections (internal/process/task_queues.js:77:11) {
Dec 16 20:49:00 volumio volumio[1001]: code: 'EADDRINUSE',
Dec 16 20:49:00 volumio volumio[1001]: errno: -98,
Dec 16 20:49:00 volumio volumio[1001]: syscall: 'listen',
Dec 16 20:49:00 volumio volumio[1001]: address: '::',
Dec 16 20:49:00 volumio volumio[1001]: port: 6599
Dec 16 20:49:00 volumio volumio[1001]: }
Dec 16 20:49:00 volumio volumio[1001]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 16 20:49:00 volumio sudo[2532]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-16 20:48
Dec 16 20:49:00 volumio sudo[2532]: 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="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 10 Jun 2025 05:26:48 PM CEST"
VOLUMIO_VERSION="3.816"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="a63f40325536655a08b14de2b295ce76"