-- Logs begin at Tue 2024-10-01 15:56:26 CST, end at Tue 2024-10-01 16:01:12 CST. --
Oct 01 16:00:36 volumio sudo[2258]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Oct 01 16:00:36 volumio sudo[2256]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Oct 01 16:00:36 volumio sudo[2258]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 01 16:00:36 volumio sudo[2256]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 01 16:00:36 volumio sudo[2258]: pam_unix(sudo:session): session closed for user root
Oct 01 16:00:36 volumio sudo[2256]: pam_unix(sudo:session): session closed for user root
Oct 01 16:00:37 volumio volumio[1249]: verbose: New Socket.io Connection to 192.168.50.158 from 192.168.50.42 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/120.0.0.0 Safari/537.36 Edg/120.0.0.0 Engine version: 3 Transport: polling Total Clients: 6
Oct 01 16:00:37 volumio sudo[2262]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Oct 01 16:00:37 volumio sudo[2262]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 01 16:00:37 volumio sudo[2262]: pam_unix(sudo:session): session closed for user root
Oct 01 16:00:37 volumio sudo[2265]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Oct 01 16:00:37 volumio sudo[2265]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 01 16:00:37 volumio sudo[2265]: pam_unix(sudo:session): session closed for user root
Oct 01 16:00:37 volumio volumio[1249]: verbose: New Socket.io Connection to 192.168.50.158 from 192.168.50.42 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/120.0.0.0 Safari/537.36 Edg/120.0.0.0 Engine version: 3 Transport: polling Total Clients: 7
Oct 01 16:00:37 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Oct 01 16:00:37 volumio volumio[1249]: info: CoreCommandRouter::volumioGetVisibleSources
Oct 01 16:00:37 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Oct 01 16:00:37 volumio volumio[1249]: info: CoreCommandRouter::volumioGetState
Oct 01 16:00:37 volumio volumio[1249]: info: CorePlayQueue::getTrack 0
Oct 01 16:00:37 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Oct 01 16:00:37 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Oct 01 16:00:37 volumio volumio[1249]: info: Received Get System Info
Oct 01 16:00:37 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 01 16:00:37 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 01 16:00:37 volumio volumio[1249]: info: Discovery: Getting this device information
Oct 01 16:00:37 volumio volumio[1249]: info: CoreCommandRouter::volumioGetState
Oct 01 16:00:37 volumio volumio[1249]: info: CorePlayQueue::getTrack 0
Oct 01 16:00:37 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 01 16:00:37 volumio volumio[1249]: info: CoreCommandRouter::volumioGetState
Oct 01 16:00:37 volumio volumio[1249]: info: CorePlayQueue::getTrack 0
Oct 01 16:00:37 volumio volumio[1249]: info: Listing playlists
Oct 01 16:00:37 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Oct 01 16:00:37 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Oct 01 16:00:37 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Oct 01 16:00:38 volumio volumio[1249]: info: CoreCommandRouter::volumioGetState
Oct 01 16:00:38 volumio volumio[1249]: info: CorePlayQueue::getTrack 0
Oct 01 16:00:39 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Oct 01 16:00:39 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Oct 01 16:00:39 volumio volumio[1249]: info: Received Get System Info
Oct 01 16:00:39 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 01 16:00:39 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 01 16:00:39 volumio volumio[1249]: info: Discovery: Getting this device information
Oct 01 16:00:39 volumio volumio[1249]: info: CoreCommandRouter::volumioGetState
Oct 01 16:00:39 volumio volumio[1249]: info: CorePlayQueue::getTrack 0
Oct 01 16:00:39 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 01 16:00:43 volumio volumio[1249]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 01 16:00:43 volumio volumio[1249]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 01 16:00:43 volumio volumio[1249]: info: Retrieving Cloud Streaming UI
Oct 01 16:00:43 volumio volumio[1249]: info: Getting Tidal Cloud Configuration
Oct 01 16:00:43 volumio volumio[1249]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 01 16:00:43 volumio volumio[1249]: info: Getting Qobuz Cloud Configuration
Oct 01 16:00:43 volumio volumio[1249]: info: Asking plugin for UI Config
Oct 01 16:00:43 volumio volumio[1249]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 01 16:00:43 volumio volumio[1249]: info: Getting Spotify Cloud Configuration
Oct 01 16:00:43 volumio volumio[1249]: info: Asking plugin for UI Config
Oct 01 16:00:43 volumio volumio[1249]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 01 16:00:43 volumio volumio[1249]: info: Saving Spotify Acccount
Oct 01 16:00:43 volumio volumio[1249]: info: Got Tidal Cloud Configuration
Oct 01 16:00:43 volumio volumio[1249]: info: Got it
Oct 01 16:00:43 volumio volumio[1249]: info: Got it
Oct 01 16:00:43 volumio volumio[1249]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Oct 01 16:00:43 volumio volumio[1249]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 01 16:00:43 volumio volumio[1249]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
Oct 01 16:00:43 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Oct 01 16:00:43 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Oct 01 16:00:43 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Oct 01 16:00:43 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Oct 01 16:00:43 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 01 16:00:43 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 01 16:00:43 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 01 16:00:43 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 01 16:00:43 volumio volumio[1249]: info: CoreCommandRouter::volumioGetBrowseSources
Oct 01 16:00:43 volumio volumio[1249]: info: CoreCommandRouter::volumioGetBrowseSources
Oct 01 16:00:43 volumio volumio[1249]: info: CoreCommandRouter::volumioGetBrowseSources
Oct 01 16:00:43 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 01 16:00:43 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Oct 01 16:00:45 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb
Oct 01 16:00:45 volumio volumio[1249]: verbose: ControllerMpd::sendMpdCommand update
Oct 01 16:00:45 volumio volumio[1249]: info: sendMpdCommand update took 5 milliseconds
Oct 01 16:00:45 volumio volumio[1249]: verbose: ControllerMpd::sendMpdCommand status
Oct 01 16:00:45 volumio volumio[1249]: info:
Oct 01 16:00:45 volumio volumio[1249]: ---------------------------- MPD announces state update: update
Oct 01 16:00:45 volumio volumio[1249]: info: ControllerMpd::getState
Oct 01 16:00:45 volumio volumio[1249]: verbose: ControllerMpd::sendMpdCommand status
Oct 01 16:00:45 volumio volumio[1249]: verbose: ControllerMpd::sendMpdCommand status
Oct 01 16:00:45 volumio volumio[1249]: info:
Oct 01 16:00:45 volumio volumio[1249]: ---------------------------- MPD announces state update: update
Oct 01 16:00:45 volumio volumio[1249]: info: ControllerMpd::getState
Oct 01 16:00:45 volumio volumio[1249]: verbose: ControllerMpd::sendMpdCommand status
Oct 01 16:00:45 volumio volumio[1249]: verbose: ControllerMpd::sendMpdCommand status
Oct 01 16:00:45 volumio volumio[1249]: info:
Oct 01 16:00:45 volumio volumio[1249]: ---------------------------- MPD announces state update: update
Oct 01 16:00:45 volumio volumio[1249]: info: ControllerMpd::getState
Oct 01 16:00:45 volumio volumio[1249]: verbose: ControllerMpd::sendMpdCommand status
Oct 01 16:00:45 volumio volumio[1249]: info: sendMpdCommand status took 11 milliseconds
Oct 01 16:00:45 volumio volumio[1249]: info: sendMpdCommand status took 8 milliseconds
Oct 01 16:00:45 volumio volumio[1249]: info: sendMpdCommand status took 8 milliseconds
Oct 01 16:00:45 volumio volumio[1249]: info: sendMpdCommand status took 6 milliseconds
Oct 01 16:00:45 volumio volumio[1249]: info: sendMpdCommand status took 6 milliseconds
Oct 01 16:00:45 volumio volumio[1249]: info: sendMpdCommand status took 5 milliseconds
Oct 01 16:00:45 volumio volumio[1249]: verbose: ControllerMpd::parseState
Oct 01 16:00:45 volumio volumio[1249]: info: Command Router : Notfying DB Updatetrue
Oct 01 16:00:45 volumio volumio[1249]: verbose: ControllerMpd::parseState
Oct 01 16:00:45 volumio volumio[1249]: verbose: ControllerMpd::parseState
Oct 01 16:00:45 volumio volumio[1249]: info: Command Router : Notfying DB Updatetrue
Oct 01 16:00:45 volumio volumio[1249]: info: CoreCommandRouter::Close All Modals sent
Oct 01 16:00:45 volumio volumio[1249]: verbose: ControllerMpd::parseState
Oct 01 16:00:45 volumio volumio[1249]: verbose: ControllerMpd::parseState
Oct 01 16:00:45 volumio volumio[1249]: info: Command Router : Notfying DB Updatetrue
Oct 01 16:00:45 volumio volumio[1249]: info: CoreCommandRouter::Close All Modals sent
Oct 01 16:00:45 volumio volumio[1249]: verbose: ControllerMpd::parseState
Oct 01 16:00:45 volumio volumio[1249]: info: ControllerMpd::pushState
Oct 01 16:00:45 volumio volumio[1249]: info: CoreCommandRouter::servicePushState
Oct 01 16:00:45 volumio volumio[1249]: info: CoreStateMachine::pushState
Oct 01 16:00:45 volumio volumio[1249]: info: CorePlayQueue::getTrack 0
Oct 01 16:00:45 volumio volumio[1249]: info: CoreCommandRouter::volumioPushState
Oct 01 16:00:45 volumio volumio[1249]: info: CorePlayQueue::getTrack 0
Oct 01 16:00:45 volumio volumio[1249]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Oct 01 16:00:45 volumio volumio[1249]: verbose: CURRENT POSITION 0
Oct 01 16:00:45 volumio volumio[1249]: info: CoreStateMachine::syncState stateService stop
Oct 01 16:00:45 volumio volumio[1249]: info: CoreStateMachine::syncState currentStatus stop
Oct 01 16:00:45 volumio volumio[1249]: info: CoreStateMachine::pushState
Oct 01 16:00:45 volumio volumio[1249]: info: CorePlayQueue::getTrack 0
Oct 01 16:00:45 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 01 16:00:45 volumio volumio[1249]: info: CoreCommandRouter::volumioPushState
Oct 01 16:00:45 volumio volumio[1249]: info: No code
Oct 01 16:00:45 volumio volumio[1249]: info: CoreStateMachine::pushState
Oct 01 16:00:45 volumio volumio[1249]: info: CorePlayQueue::getTrack 0
Oct 01 16:00:45 volumio volumio[1249]: info: CoreCommandRouter::volumioPushState
Oct 01 16:00:45 volumio volumio[1249]: info: ControllerMpd::pushState
Oct 01 16:00:45 volumio volumio[1249]: info: CoreCommandRouter::servicePushState
Oct 01 16:00:45 volumio volumio[1249]: info: CoreStateMachine::pushState
Oct 01 16:00:45 volumio volumio[1249]: info: CorePlayQueue::getTrack 0
Oct 01 16:00:45 volumio volumio[1249]: info: CoreCommandRouter::volumioPushState
Oct 01 16:00:45 volumio volumio[1249]: info: CorePlayQueue::getTrack 0
Oct 01 16:00:45 volumio volumio[1249]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Oct 01 16:00:45 volumio volumio[1249]: verbose: CURRENT POSITION 0
Oct 01 16:00:45 volumio volumio[1249]: info: CoreStateMachine::syncState stateService stop
Oct 01 16:00:45 volumio volumio[1249]: info: CoreStateMachine::syncState currentStatus stop
Oct 01 16:00:45 volumio volumio[1249]: info: CoreStateMachine::pushState
Oct 01 16:00:45 volumio volumio[1249]: info: CorePlayQueue::getTrack 0
Oct 01 16:00:45 volumio volumio[1249]: info: CoreCommandRouter::volumioPushState
Oct 01 16:00:45 volumio volumio[1249]: info: No code
Oct 01 16:00:45 volumio volumio[1249]: info: CoreStateMachine::pushState
Oct 01 16:00:45 volumio volumio[1249]: info: CorePlayQueue::getTrack 0
Oct 01 16:00:45 volumio volumio[1249]: info: CoreCommandRouter::volumioPushState
Oct 01 16:00:45 volumio volumio[1249]: info: ControllerMpd::pushState
Oct 01 16:00:45 volumio volumio[1249]: info: CoreCommandRouter::servicePushState
Oct 01 16:00:45 volumio volumio[1249]: info: CoreStateMachine::pushState
Oct 01 16:00:45 volumio volumio[1249]: info: CorePlayQueue::getTrack 0
Oct 01 16:00:45 volumio volumio[1249]: info: CoreCommandRouter::volumioPushState
Oct 01 16:00:45 volumio volumio[1249]: info: CorePlayQueue::getTrack 0
Oct 01 16:00:45 volumio volumio[1249]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Oct 01 16:00:45 volumio volumio[1249]: verbose: CURRENT POSITION 0
Oct 01 16:00:45 volumio volumio[1249]: info: CoreStateMachine::syncState stateService stop
Oct 01 16:00:45 volumio volumio[1249]: info: CoreStateMachine::syncState currentStatus stop
Oct 01 16:00:45 volumio volumio[1249]: info: CoreStateMachine::pushState
Oct 01 16:00:45 volumio volumio[1249]: info: CorePlayQueue::getTrack 0
Oct 01 16:00:45 volumio volumio[1249]: info: CoreCommandRouter::volumioPushState
Oct 01 16:00:45 volumio volumio[1249]: info: No code
Oct 01 16:00:45 volumio volumio[1249]: info: CoreStateMachine::pushState
Oct 01 16:00:45 volumio volumio[1249]: info: CorePlayQueue::getTrack 0
Oct 01 16:00:45 volumio volumio[1249]: info: CoreCommandRouter::volumioPushState
Oct 01 16:00:45 volumio volumio[1249]: info: ------------------------------ 343ms
Oct 01 16:00:45 volumio volumio[1249]: info: ------------------------------ 342ms
Oct 01 16:00:45 volumio volumio[1249]: info: ------------------------------ 341ms
Oct 01 16:00:47 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 01 16:00:47 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Oct 01 16:00:51 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 01 16:00:55 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 01 16:00:59 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 01 16:01:03 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 01 16:01:06 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares
Oct 01 16:01:06 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService
Oct 01 16:01:07 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 01 16:01:11 volumio volumio[1249]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 01 16:01:11 volumio volumio[1249]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 01 16:01:11 volumio volumio[1249]: Error: dns service error: unknown
Oct 01 16:01:11 volumio volumio[1249]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30)
Oct 01 16:01:11 volumio volumio[1249]: at SocketWatcher.MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) {
Oct 01 16:01:11 volumio volumio[1249]: errorCode: -65537
Oct 01 16:01:11 volumio volumio[1249]: }
Oct 01 16:01:11 volumio volumio[1249]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 01 16:01:12 volumio sudo[2292]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-01 16:00
Oct 01 16:01:12 volumio sudo[2292]: 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:33:09 PM CEST"
VOLUMIO_VERSION="3.757"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="ee834e1c2a28de3c5d8c48611ecf1167"