-- Logs begin at Fri 2025-04-25 14:27:11 UTC, end at Fri 2025-04-25 14:44:16 UTC. --
Apr 25 14:43:15 volumio ntpd[1158]: 91.206.16.3 local addr 192.168.1.110 ->
Apr 25 14:43:33 volumio volumio[1265]: info: CALLMETHOD: system_controller system setTestPlugins true
Apr 25 14:43:33 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: system , setTestPlugins
Apr 25 14:43:33 volumio volumio[1265]: info: Plugins store is now in test mode
Apr 25 14:43:35 volumio volumio[1265]: info: CALLMETHOD: system_controller system setTestPlugins false
Apr 25 14:43:35 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: system , setTestPlugins
Apr 25 14:43:35 volumio volumio[1265]: info: Plugins Test File deleted
Apr 25 14:43:38 volumio volumio[1265]: info: CALLMETHOD: system_controller system setTestSystem true
Apr 25 14:43:38 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: system , setTestSystem
Apr 25 14:43:38 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: updater_comm , checkUpdates
Apr 25 14:43:38 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Apr 25 14:43:38 volumio volumio[1265]: info: Device is now in test mode
Apr 25 14:43:39 volumio volumio-remote-updater[796]: Test mode enabled
Apr 25 14:43:39 volumio volumio-remote-updater[796]: No alpha test mode
Apr 25 14:43:39 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Apr 25 14:43:39 volumio volumio[1265]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"FIXES
\n\n- Slow down CD read speed
\n- Fix NAS Mounting
\n
\nNEW ADDITIONS
\n\n- Revert TIDAL Connect to working version
\n- Fix for USB DAC not recognized after OTA update
\n
\n","title":"Update v3.804","updateavailable":true}
Apr 25 14:43:39 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Apr 25 14:43:47 volumio volumio[1265]: info: CALLMETHOD: system_controller system enableLiveLog true
Apr 25 14:43:47 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: system , enableLiveLog
Apr 25 14:43:47 volumio volumio[1265]: info: Launching a new LiveLog session
Apr 25 14:44:01 volumio volumio[1265]: info: CALLMETHOD: system_controller system enableSSH true
Apr 25 14:44:01 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: system , enableSSH
Apr 25 14:44:01 volumio sudo[4582]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start ssh.service
Apr 25 14:44:01 volumio sudo[4582]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 25 14:44:01 volumio sudo[4582]: pam_unix(sudo:session): session closed for user root
Apr 25 14:44:01 volumio sudo[4584]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl enable ssh.service
Apr 25 14:44:01 volumio sudo[4584]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 25 14:44:01 volumio systemd[1]: Reloading.
Apr 25 14:44:02 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly.
Apr 25 14:44:02 volumio systemd[1]: Reloading.
Apr 25 14:44:02 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly.
Apr 25 14:44:02 volumio systemd[1]: Reloading.
Apr 25 14:44:02 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly.
Apr 25 14:44:02 volumio sudo[4584]: pam_unix(sudo:session): session closed for user root
Apr 25 14:44:02 volumio volumio[1265]: info: enable SSH service success
Apr 25 14:44:08 volumio sudo[4634]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 25 14:44:08 volumio sudo[4634]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 25 14:44:08 volumio sudo[4634]: pam_unix(sudo:session): session closed for user root
Apr 25 14:44:08 volumio sudo[4637]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 25 14:44:08 volumio sudo[4637]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 25 14:44:08 volumio sudo[4637]: pam_unix(sudo:session): session closed for user root
Apr 25 14:44:09 volumio volumio[1265]: verbose: New Socket.io Connection to 192.168.1.110 from 192.168.1.72 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/135.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7
Apr 25 14:44:09 volumio volumio[1265]: info: CoreCommandRouter::volumioGetVisibleSources
Apr 25 14:44:09 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 25 14:44:09 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Apr 25 14:44:09 volumio volumio[1265]: info: CoreCommandRouter::volumioGetState
Apr 25 14:44:09 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Apr 25 14:44:09 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Apr 25 14:44:09 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Apr 25 14:44:09 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Apr 25 14:44:09 volumio sudo[4654]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 25 14:44:09 volumio sudo[4654]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 25 14:44:09 volumio sudo[4654]: pam_unix(sudo:session): session closed for user root
Apr 25 14:44:09 volumio sudo[4657]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 25 14:44:09 volumio sudo[4657]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 25 14:44:09 volumio sudo[4657]: pam_unix(sudo:session): session closed for user root
Apr 25 14:44:09 volumio volumio[1265]: verbose: New Socket.io Connection to 192.168.1.110 from 192.168.1.72 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/135.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8
Apr 25 14:44:10 volumio volumio[1265]: info: CoreCommandRouter::volumioGetState
Apr 25 14:44:10 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Apr 25 14:44:10 volumio volumio[1265]: info: CoreCommandRouter::volumioGetVisibleSources
Apr 25 14:44:10 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 25 14:44:10 volumio volumio[1265]: info: Listing playlists
Apr 25 14:44:10 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Apr 25 14:44:10 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Apr 25 14:44:10 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Apr 25 14:44:10 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Apr 25 14:44:12 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Apr 25 14:44:12 volumio volumio[1265]: info: Received Get System Info
Apr 25 14:44:12 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 25 14:44:12 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 25 14:44:12 volumio volumio[1265]: info: Discovery: Getting this device information
Apr 25 14:44:12 volumio volumio[1265]: info: CoreCommandRouter::volumioGetState
Apr 25 14:44:12 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 25 14:44:12 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Apr 25 14:44:13 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Apr 25 14:44:13 volumio volumio[1265]: info: Received Get System Info
Apr 25 14:44:13 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 25 14:44:13 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 25 14:44:13 volumio volumio[1265]: info: Discovery: Getting this device information
Apr 25 14:44:13 volumio volumio[1265]: info: CoreCommandRouter::volumioGetState
Apr 25 14:44:13 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 25 14:44:13 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Apr 25 14:44:14 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri
Apr 25 14:44:14 volumio volumio[1265]: info: [1745592254427] ControllerQobuz::handleBrowseUri
Apr 25 14:44:14 volumio volumio[1265]: info: [1745592254427] ControllerQobuz::handleBrowseUri: "qobuz"
Apr 25 14:44:14 volumio volumio[1265]: info: Preload queue cleared
Apr 25 14:44:14 volumio volumio[1265]: info: CoreCommandRouter::volumioGetQueue
Apr 25 14:44:14 volumio volumio[1265]: info: CoreStateMachine::getQueue
Apr 25 14:44:14 volumio volumio[1265]: info: CorePlayQueue::getQueue
Apr 25 14:44:14 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Apr 25 14:44:14 volumio volumio[1265]: info: Received Get System Info
Apr 25 14:44:14 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 25 14:44:14 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 25 14:44:14 volumio volumio[1265]: info: Discovery: Getting this device information
Apr 25 14:44:14 volumio volumio[1265]: info: CoreCommandRouter::volumioGetState
Apr 25 14:44:14 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 25 14:44:16 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Apr 25 14:44:16 volumio volumio[1265]: info: Received Get System Info
Apr 25 14:44:16 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 25 14:44:16 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 25 14:44:16 volumio volumio[1265]: info: Discovery: Getting this device information
Apr 25 14:44:16 volumio volumio[1265]: info: CoreCommandRouter::volumioGetState
Apr 25 14:44:16 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 25 14:44:16 volumio volumio[1265]: info: Preload queue cleared
Apr 25 14:44:16 volumio volumio[1265]: info: CoreCommandRouter::volumioReplaceandPlayItems
Apr 25 14:44:16 volumio volumio[1265]: info: CoreStateMachine::ClearQueue
Apr 25 14:44:16 volumio volumio[1265]: info: CoreStateMachine::stop
Apr 25 14:44:16 volumio volumio[1265]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 25 14:44:16 volumio volumio[1265]: info: CoreStateMachine::stPlaybackTimer
Apr 25 14:44:16 volumio volumio[1265]: info: CoreStateMachine::updateTrackBlock
Apr 25 14:44:16 volumio volumio[1265]: info: CorePlayQueue::getTrackBlock
Apr 25 14:44:16 volumio volumio[1265]: info: CoreStateMachine::pushState
Apr 25 14:44:16 volumio volumio[1265]: info: CorePlayQueue::getTrack 0
Apr 25 14:44:16 volumio volumio[1265]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 25 14:44:16 volumio volumio[1265]: info: CoreCommandRouter::volumioPushState
Apr 25 14:44:16 volumio volumio[1265]: info: CoreStateMachine::serviceStop
Apr 25 14:44:16 volumio volumio[1265]: info: CorePlayQueue::getTrack 0
Apr 25 14:44:16 volumio volumio[1265]: info: CoreCommandRouter::serviceStop
Apr 25 14:44:16 volumio volumio[1265]: info: [1745592256361] ControllerWebradio::stop
Apr 25 14:44:16 volumio volumio[1265]: verbose: ControllerMpd::sendMpdCommand stop
Apr 25 14:44:16 volumio volumio[1265]: info: CorePlayQueue::clearPlayQueue
Apr 25 14:44:16 volumio volumio[1265]: info: CorePlayQueue::saveQueue
Apr 25 14:44:16 volumio volumio[1265]: info: CoreCommandRouter::volumioPushQueue
Apr 25 14:44:16 volumio volumio[1265]: info: CoreStateMachine::addQueueItems
Apr 25 14:44:16 volumio volumio[1265]: info: CorePlayQueue::addQueueItems
Apr 25 14:44:16 volumio volumio[1265]: info: Preload queue cleared
Apr 25 14:44:16 volumio volumio[1265]: info: Adding Item to queue: qobuz/genres
Apr 25 14:44:16 volumio volumio[1265]: info: Exploding uri qobuz/genres in service qobuz
Apr 25 14:44:16 volumio volumio[1265]: info: [1745592256363] ControllerQobuz::explodeUri start uri: qobuz/genres
Apr 25 14:44:16 volumio volumio[1265]: info: [1745592256363] ControllerQobuz::explodeUri no uri pattern matched
Apr 25 14:44:16 volumio volumio[1265]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 25 14:44:16 volumio volumio[1265]: TypeError: exploder is not a function
Apr 25 14:44:16 volumio volumio[1265]: at ControllerQobuz.explodeUri (/data/plugins/music_service/qobuz/index.js:492:12)
Apr 25 14:44:16 volumio volumio[1265]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1384:16)
Apr 25 14:44:16 volumio volumio[1265]: at CorePlayQueue.explodeUriFromCache (/volumio/app/playqueue.js:123:24)
Apr 25 14:44:16 volumio volumio[1265]: at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:181:19)
Apr 25 14:44:16 volumio volumio[1265]: at CorePlayQueue.addQueueItems (/volumio/app/playqueue.js:223:30)
Apr 25 14:44:16 volumio volumio[1265]: at CoreStateMachine.addQueueItems (/volumio/app/statemachine.js:247:25)
Apr 25 14:44:16 volumio volumio[1265]: at CoreCommandRouter.replaceAndPlay (/volumio/app/index.js:526:23)
Apr 25 14:44:16 volumio volumio[1265]: at CoreCommandRouter.playItemsList (/volumio/app/index.js:484:17)
Apr 25 14:44:16 volumio volumio[1265]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:142:33)
Apr 25 14:44:16 volumio volumio[1265]: at Socket.emit (events.js:400:28)
Apr 25 14:44:16 volumio volumio[1265]: at /volumio/node_modules/socket.io/lib/socket.js:528:12
Apr 25 14:44:16 volumio volumio[1265]: at processTicksAndRejections (internal/process/task_queues.js:77:11)
Apr 25 14:44:16 volumio volumio[1265]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 25 14:44:16 volumio sudo[4712]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-25 14:43
Apr 25 14:44:16 volumio sudo[4712]: 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="e32c2c71ae78852844c70357816bdd871c155ab8"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Mon 31 Mar 2025 07:27:48 PM CEST"
VOLUMIO_VERSION="3.799"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="4bc1ecb08f34ad14b420d6678a2aef1b"