-- Logs begin at Tue 2024-10-08 03:02:09 CEST, end at Tue 2024-10-08 05:01:33 CEST. -- Oct 08 05:00:00 volumio sudo[14077]: volumio : unable to resolve host volumio Oct 08 05:00:00 volumio sudo[14077]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Oct 08 05:00:00 volumio sudo[14077]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 08 05:00:00 volumio sudo[14077]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 08 05:00:00 volumio sudo[14077]: pam_unix(sudo:session): session closed for user root Oct 08 05:00:00 volumio volumio[763]: info: MPD Permissions set Oct 08 05:00:00 volumio sudo[14079]: volumio : unable to resolve host volumio Oct 08 05:00:00 volumio sudo[14079]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Oct 08 05:00:00 volumio sudo[14079]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 08 05:00:00 volumio sudo[14079]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 08 05:00:00 volumio volumio[763]: ------------------------------------ BT MESSAGE: BT STATUS: running Oct 08 05:00:00 volumio sudo[14085]: volumio : unable to resolve host volumio Oct 08 05:00:00 volumio sudo[14085]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Oct 08 05:00:00 volumio sudo[14085]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 08 05:00:00 volumio sudo[14085]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 08 05:00:00 volumio sudo[14085]: pam_unix(sudo:session): session closed for user root Oct 08 05:00:00 volumio volumio[763]: info: MPD Permissions set Oct 08 05:00:00 volumio sudo[14087]: volumio : unable to resolve host volumio Oct 08 05:00:00 volumio sudo[14087]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Oct 08 05:00:00 volumio sudo[14087]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 08 05:00:00 volumio sudo[14087]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 08 05:00:00 volumio volumio[763]: ------------------------------------ BT MESSAGE: BT STATUS: running Oct 08 05:00:16 volumio sudo[14098]: root : unable to resolve host volumio Oct 08 05:00:16 volumio sudo[14098]: root : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Oct 08 05:00:16 volumio sudo[14098]: sudo: unable to resolve host volumio: System error Oct 08 05:00:16 volumio sudo[14098]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 08 05:00:16 volumio sudo[14098]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 08 05:00:16 volumio sudo[14098]: pam_unix(sudo:session): session closed for user root Oct 08 05:00:16 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Oct 08 05:00:16 volumio systemd[1]: mpd.service: Succeeded. Oct 08 05:00:16 volumio systemd[1]: Stopped Music Player Daemon. Oct 08 05:00:16 volumio volumio[763]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Oct 08 05:00:16 volumio systemd[1]: Starting Music Player Daemon... Oct 08 05:00:16 volumio volumio[763]: ------------------------------------ BT MESSAGE: BT STATUS: running Oct 08 05:00:25 volumio volumio[763]: info: CALLMETHOD: music_service mpd savePlaybackOptions [object Object] Oct 08 05:00:25 volumio volumio[763]: info: CoreCommandRouter::executeOnPlugin: mpd , savePlaybackOptions Oct 08 05:00:25 volumio volumio[763]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 08 05:00:25 volumio volumio[763]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 08 05:00:25 volumio volumio[763]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 08 05:00:25 volumio volumio[763]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 08 05:00:25 volumio volumio[763]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 08 05:00:25 volumio volumio[763]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 08 05:00:25 volumio volumio[763]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 08 05:00:25 volumio volumio[763]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 08 05:00:25 volumio volumio[763]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 08 05:00:25 volumio volumio[763]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 08 05:00:36 volumio sudo[14115]: root : unable to resolve host volumio Oct 08 05:00:36 volumio sudo[14115]: root : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Oct 08 05:00:36 volumio sudo[14115]: sudo: unable to resolve host volumio: System error Oct 08 05:00:36 volumio sudo[14115]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 08 05:00:36 volumio sudo[14115]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 08 05:00:36 volumio sudo[14115]: pam_unix(sudo:session): session closed for user root Oct 08 05:00:37 volumio mpd[14188]: Oct 08 05:00 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 08 05:00:37 volumio systemd[1]: Started Music Player Daemon. Oct 08 05:00:37 volumio sudo[14039]: pam_unix(sudo:session): session closed for user root Oct 08 05:00:37 volumio sudo[14087]: pam_unix(sudo:session): session closed for user root Oct 08 05:00:37 volumio sudo[14047]: pam_unix(sudo:session): session closed for user root Oct 08 05:00:37 volumio sudo[14079]: pam_unix(sudo:session): session closed for user root Oct 08 05:00:37 volumio sudo[14031]: pam_unix(sudo:session): session closed for user root Oct 08 05:00:37 volumio sudo[14063]: pam_unix(sudo:session): session closed for user root Oct 08 05:00:37 volumio sudo[14071]: pam_unix(sudo:session): session closed for user root Oct 08 05:00:37 volumio sudo[14055]: pam_unix(sudo:session): session closed for user root Oct 08 05:00:37 volumio volumio[763]: error: MPD error: The expression evaluated to a falsy value: Oct 08 05:00:37 volumio volumio[763]: assert.ok(self.idling) Oct 08 05:00:37 volumio volumio[763]: error: The expression evaluated to a falsy value: Oct 08 05:00:37 volumio volumio[763]: assert.ok(self.idling) Oct 08 05:00:37 volumio volumio[763]: error: MPD error: The expression evaluated to a falsy value: Oct 08 05:00:37 volumio volumio[763]: assert.ok(self.idling) Oct 08 05:00:37 volumio volumio[763]: error: The expression evaluated to a falsy value: Oct 08 05:00:37 volumio volumio[763]: assert.ok(self.idling) Oct 08 05:00:37 volumio volumio[763]: error: MPD error: The expression evaluated to a falsy value: Oct 08 05:00:37 volumio volumio[763]: assert.ok(self.idling) Oct 08 05:00:37 volumio volumio[763]: error: The expression evaluated to a falsy value: Oct 08 05:00:37 volumio volumio[763]: assert.ok(self.idling) Oct 08 05:00:37 volumio volumio[763]: error: MPD error: The expression evaluated to a falsy value: Oct 08 05:00:37 volumio volumio[763]: assert.ok(self.idling) Oct 08 05:00:37 volumio volumio[763]: error: The expression evaluated to a falsy value: Oct 08 05:00:37 volumio volumio[763]: assert.ok(self.idling) Oct 08 05:00:37 volumio volumio[763]: error: MPD error: The expression evaluated to a falsy value: Oct 08 05:00:37 volumio volumio[763]: assert.ok(self.idling) Oct 08 05:00:37 volumio volumio[763]: error: The expression evaluated to a falsy value: Oct 08 05:00:37 volumio volumio[763]: assert.ok(self.idling) Oct 08 05:00:37 volumio volumio[763]: error: MPD error: The expression evaluated to a falsy value: Oct 08 05:00:37 volumio volumio[763]: assert.ok(self.idling) Oct 08 05:00:37 volumio volumio[763]: error: The expression evaluated to a falsy value: Oct 08 05:00:37 volumio volumio[763]: assert.ok(self.idling) Oct 08 05:00:37 volumio volumio[763]: error: MPD error: The expression evaluated to a falsy value: Oct 08 05:00:37 volumio volumio[763]: assert.ok(self.idling) Oct 08 05:00:37 volumio volumio[763]: error: The expression evaluated to a falsy value: Oct 08 05:00:37 volumio volumio[763]: assert.ok(self.idling) Oct 08 05:00:37 volumio volumio[763]: error: updateQueue error: null Oct 08 05:00:44 volumio volumio[763]: info: CALLMETHOD: audio_interface alsa_controller saveVolumeOptions [object Object] Oct 08 05:00:44 volumio volumio[763]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveVolumeOptions Oct 08 05:00:44 volumio volumio[763]: info: CoreCommandRouter::volumioGetState Oct 08 05:00:44 volumio volumio[763]: info: CorePlayQueue::getTrack 0 Oct 08 05:00:44 volumio volumio[763]: info: Restoring Previous Volume level: 86 false false Oct 08 05:00:44 volumio volumio[763]: info: Volume configurations have been set Oct 08 05:00:44 volumio vtcs[3190]: [2024-10-08 05:00:44.233] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE Oct 08 05:00:44 volumio vtcs[3190]: [2024-10-08 05:00:44.234] [tisoc] [error] [SpkconServer.cpp:381] recv error. client fd=8 errorno=104 error=Connection reset by peer Oct 08 05:00:44 volumio vtcs[3190]: [2024-10-08 05:00:44.234] [tisoc] [error] [SpkconServer.cpp:376] recv error. socket disconnected Oct 08 05:00:44 volumio volumio[763]: info: CoreCommandRouter::volumioUpdateVolumeSettings Oct 08 05:00:44 volumio volumio[763]: info: Updating Volume Controller Parameters: Device: 0 Name: Headphones Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 2 Oct 08 05:00:44 volumio volumio[763]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Oct 08 05:00:44 volumio volumio[763]: info: Disabling external Volume Control Oct 08 05:00:44 volumio volumio[763]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 08 05:00:44 volumio volumio[763]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 08 05:00:44 volumio volumio[763]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 08 05:00:44 volumio volumio[763]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 08 05:00:44 volumio volumio[763]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 08 05:00:44 volumio volumio[763]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 08 05:00:44 volumio volumio[763]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 08 05:00:44 volumio volumio[763]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 08 05:00:44 volumio volumio[763]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 08 05:00:44 volumio volumio[763]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 08 05:00:44 volumio volumio[763]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 08 05:00:44 volumio volumio[763]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Oct 08 05:00:44 volumio volumio[763]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 08 05:00:44 volumio volumio[763]: info: VolumeController:: Volume=86 Mute =false Oct 08 05:00:44 volumio volumio[763]: info: CoreCommandRouter::volumioGetState Oct 08 05:00:44 volumio volumio[763]: info: CorePlayQueue::getTrack 0 Oct 08 05:00:44 volumio volumio[763]: info: CoreCommandRouter::volumioGetState Oct 08 05:00:44 volumio volumio[763]: info: CorePlayQueue::getTrack 0 Oct 08 05:00:44 volumio volumio[763]: info: CoreStateMachine::pushState Oct 08 05:00:44 volumio volumio[763]: info: CorePlayQueue::getTrack 0 Oct 08 05:00:44 volumio volumio[763]: info: CoreCommandRouter::volumioPushState Oct 08 05:00:44 volumio volumio[763]: info: MRS: Pushing multiroomSync output update for this device Oct 08 05:00:44 volumio volumio[763]: info: MRS: Pushing multiroomSync output Oct 08 05:00:44 volumio volumio[763]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Oct 08 05:00:44 volumio volumio[763]: SPOTIFY: SPOTIFY VOLUME 100 Oct 08 05:00:44 volumio volumio[763]: SPOTIFY: VOLUMIO VOLUME 86 Oct 08 05:00:44 volumio volumio[763]: SPOTIFY: DELTA VOLUME ENOUGH: true Oct 08 05:00:44 volumio volumio[763]: info: Setting Spotify Volume from Volumio: 86 Oct 08 05:00:44 volumio volumio[763]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Oct 08 05:00:45 volumio sudo[14119]: volumio : unable to resolve host volumio Oct 08 05:00:45 volumio sudo[14119]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Oct 08 05:00:45 volumio sudo[14119]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 08 05:00:45 volumio sudo[14119]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 08 05:00:45 volumio sudo[14119]: pam_unix(sudo:session): session closed for user root Oct 08 05:00:45 volumio volumio[763]: info: MPD Permissions set Oct 08 05:00:45 volumio sudo[14121]: volumio : unable to resolve host volumio Oct 08 05:00:45 volumio sudo[14121]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Oct 08 05:00:45 volumio sudo[14121]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 08 05:00:45 volumio sudo[14121]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 08 05:00:45 volumio systemd[1]: Stopping Music Player Daemon... Oct 08 05:00:45 volumio volumio[763]: ------------------------------------ BT MESSAGE: BT STATUS: running Oct 08 05:00:45 volumio volumio[763]: info: CoreCommandRouter::volumioGetState Oct 08 05:00:45 volumio volumio[763]: info: CorePlayQueue::getTrack 0 Oct 08 05:00:45 volumio systemd[1]: mpd.service: Succeeded. Oct 08 05:00:45 volumio systemd[1]: Stopped Music Player Daemon. Oct 08 05:00:45 volumio volumio[763]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Oct 08 05:00:45 volumio systemd[1]: Starting Music Player Daemon... Oct 08 05:00:45 volumio volumio[763]: ------------------------------------ BT MESSAGE: BT STATUS: running Oct 08 05:00:46 volumio volumio[763]: SPOTIFY: SETTING SPOTIFY VOLUME 86 Oct 08 05:00:46 volumio volumio[763]: info: Sending Spotify command with payload to local API: /player/volume Oct 08 05:00:46 volumio go-librespot[13282]: time="2024-10-08T05:00:46+02:00" level=debug msg="update volume to 56360/65535" Oct 08 05:00:48 volumio volumio[763]: info: VolumeController::SetAlsaVolume86 Oct 08 05:00:48 volumio volumio[763]: info: CoreCommandRouter::volumioGetState Oct 08 05:00:48 volumio volumio[763]: info: CorePlayQueue::getTrack 0 Oct 08 05:00:48 volumio volumio[763]: info: CoreCommandRouter::volumioGetState Oct 08 05:00:48 volumio volumio[763]: info: CorePlayQueue::getTrack 0 Oct 08 05:00:48 volumio volumio[763]: info: CoreStateMachine::pushState Oct 08 05:00:48 volumio volumio[763]: info: CorePlayQueue::getTrack 0 Oct 08 05:00:48 volumio volumio[763]: info: CoreCommandRouter::volumioPushState Oct 08 05:00:48 volumio volumio[763]: info: MRS: Pushing multiroomSync output update for this device Oct 08 05:00:48 volumio volumio[763]: info: MRS: Pushing multiroomSync output Oct 08 05:00:48 volumio volumio[763]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Oct 08 05:00:48 volumio volumio[763]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Oct 08 05:00:51 volumio go-librespot[13282]: time="2024-10-08T05:00:51+02:00" level=debug msg="put connect state because VOLUME_CHANGED" Oct 08 05:00:51 volumio go-librespot[13282]: time="2024-10-08T05:00:51+02:00" level=trace msg="emitting websocket event: volume" Oct 08 05:00:51 volumio volumio[763]: SPOTIFY: received: {"type":"volume","data":{"value":86,"max":100}} Oct 08 05:00:51 volumio volumio[763]: SPOTIFY: RECEIVED SPOTIFY VOLUME 86 Oct 08 05:00:51 volumio volumio[763]: SPOTIFY: received: {"type":"volume","data":{"value":86,"max":100}} Oct 08 05:00:51 volumio volumio[763]: SPOTIFY: RECEIVED SPOTIFY VOLUME 86 Oct 08 05:01:02 volumio volumio[763]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 08 05:01:02 volumio volumio[763]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 08 05:01:02 volumio volumio[763]: info: Retrieving Cloud Streaming UI Oct 08 05:01:02 volumio volumio[763]: info: Getting Tidal Cloud Configuration Oct 08 05:01:02 volumio volumio[763]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 08 05:01:02 volumio volumio[763]: info: Getting Qobuz Cloud Configuration Oct 08 05:01:02 volumio volumio[763]: info: Asking plugin for UI Config Oct 08 05:01:02 volumio volumio[763]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 08 05:01:02 volumio volumio[763]: info: Getting Spotify Cloud Configuration Oct 08 05:01:02 volumio volumio[763]: info: Asking plugin for UI Config Oct 08 05:01:02 volumio volumio[763]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 08 05:01:02 volumio volumio[763]: info: Saving Spotify Acccount Oct 08 05:01:02 volumio volumio[763]: info: Got it Oct 08 05:01:02 volumio volumio[763]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Oct 08 05:01:02 volumio volumio[763]: info: Got Tidal Cloud Configuration Oct 08 05:01:02 volumio volumio[763]: info: Got it Oct 08 05:01:02 volumio volumio[763]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 08 05:01:02 volumio volumio[763]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 08 05:01:02 volumio volumio[763]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 08 05:01:02 volumio volumio[763]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 08 05:01:02 volumio volumio[763]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 08 05:01:02 volumio volumio[763]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 08 05:01:02 volumio volumio[763]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 08 05:01:02 volumio volumio[763]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 08 05:01:02 volumio volumio[763]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 08 05:01:02 volumio volumio[763]: info: CoreCommandRouter::volumioGetBrowseSources Oct 08 05:01:02 volumio volumio[763]: info: CoreCommandRouter::volumioGetBrowseSources Oct 08 05:01:02 volumio volumio[763]: info: CoreCommandRouter::volumioGetBrowseSources Oct 08 05:01:04 volumio volumio[763]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 08 05:01:04 volumio volumio[763]: error: MPD error: Error: This socket has been ended by the other party Oct 08 05:01:04 volumio volumio[763]: error: This socket has been ended by the other party {"code":"EPIPE"} Oct 08 05:01:04 volumio volumio[763]: error: MPD error: Error: This socket has been ended by the other party Oct 08 05:01:04 volumio volumio[763]: error: This socket has been ended by the other party {"code":"EPIPE"} Oct 08 05:01:04 volumio volumio[763]: error: MPD error: Error: This socket has been ended by the other party Oct 08 05:01:04 volumio volumio[763]: error: This socket has been ended by the other party {"code":"EPIPE"} Oct 08 05:01:04 volumio volumio[763]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Oct 08 05:01:04 volumio sudo[14193]: volumio : unable to resolve host volumio Oct 08 05:01:04 volumio sudo[14193]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Oct 08 05:01:04 volumio sudo[14193]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Oct 08 05:01:04 volumio sudo[14193]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 08 05:01:04 volumio systemd[1]: Stopping Volumio Tidal Connect Service... Oct 08 05:01:04 volumio systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Oct 08 05:01:04 volumio volumio[763]: ------------------------------------ BT MESSAGE: BT STATUS: running Oct 08 05:01:04 volumio systemd[1]: vtcs.service: Succeeded. Oct 08 05:01:04 volumio systemd[1]: Stopped Volumio Tidal Connect Service. Oct 08 05:01:04 volumio sudo[14193]: pam_unix(sudo:session): session closed for user root Oct 08 05:01:04 volumio sudo[14198]: volumio : unable to resolve host volumio Oct 08 05:01:04 volumio sudo[14198]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Oct 08 05:01:04 volumio sudo[14198]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Oct 08 05:01:04 volumio sudo[14198]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 08 05:01:04 volumio sudo[14198]: pam_unix(sudo:session): session closed for user root Oct 08 05:01:05 volumio sudo[14206]: root : unable to resolve host volumio Oct 08 05:01:05 volumio sudo[14206]: root : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Oct 08 05:01:05 volumio sudo[14206]: sudo: unable to resolve host volumio: System error Oct 08 05:01:05 volumio sudo[14206]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 08 05:01:05 volumio sudo[14206]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 08 05:01:05 volumio sudo[14206]: pam_unix(sudo:session): session closed for user root Oct 08 05:01:06 volumio mpd[14215]: Oct 08 05:01 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 08 05:01:06 volumio systemd[1]: Started Music Player Daemon. Oct 08 05:01:06 volumio sudo[14121]: pam_unix(sudo:session): session closed for user root Oct 08 05:01:06 volumio volumio[763]: error: updateQueue error: null Oct 08 05:01:07 volumio volumio[763]: error: Unable to stop TidalConnect service: Oct 08 05:01:07 volumio volumio[763]: info: TidalConnect service stoped! Oct 08 05:01:07 volumio volumio[763]: error: Unable to stop TidalConnect service: Oct 08 05:01:07 volumio volumio[763]: info: TidalConnect service stoped! Oct 08 05:01:07 volumio volumio[763]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Oct 08 05:01:07 volumio volumio[763]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Oct 08 05:01:07 volumio volumio[763]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Oct 08 05:01:07 volumio volumio[763]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Oct 08 05:01:07 volumio volumio[763]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 08 05:01:12 volumio volumio[763]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 08 05:01:12 volumio volumio[763]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 08 05:01:12 volumio volumio[763]: Error: dns service error: unknown Oct 08 05:01:12 volumio volumio[763]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30) Oct 08 05:01:12 volumio volumio[763]: at SocketWatcher.MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Oct 08 05:01:12 volumio volumio[763]: errorCode: -65537 Oct 08 05:01:12 volumio volumio[763]: } Oct 08 05:01:12 volumio volumio[763]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 08 05:01:27 volumio sudo[14230]: volumio : unable to resolve host volumio Oct 08 05:01:27 volumio sudo[14230]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Oct 08 05:01:27 volumio sudo[14230]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Oct 08 05:01:27 volumio sudo[14230]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 08 05:01:27 volumio systemd[1]: Started Volumio Tidal Connect Service. Oct 08 05:01:27 volumio sudo[14230]: pam_unix(sudo:session): session closed for user root Oct 08 05:01:29 volumio volumio-remote-updater[511]: [2024-10-08 03:01:29] [disconnect] Disconnect close local:[1008,Pong timeout] remote:[1006] Oct 08 05:01:29 volumio kernel: usb 1-1.3: USB disconnect, device number 5 Oct 08 05:01:29 volumio kernel: usb 1-1.3.1: USB disconnect, device number 6 Oct 08 05:01:30 volumio kernel: usb 1-1.3: new high-speed USB device number 7 using xhci_hcd Oct 08 05:01:30 volumio kernel: usb 1-1.3: New USB device found, idVendor=05e3, idProduct=0610, bcdDevice=32.98 Oct 08 05:01:30 volumio kernel: usb 1-1.3: New USB device strings: Mfr=0, Product=1, SerialNumber=0 Oct 08 05:01:30 volumio kernel: usb 1-1.3: Product: USB2.0 Hub Oct 08 05:01:30 volumio kernel: hub 1-1.3:1.0: USB hub found Oct 08 05:01:30 volumio kernel: hub 1-1.3:1.0: 4 ports detected Oct 08 05:01:31 volumio kernel: usb 1-1.3.1: new low-speed USB device number 8 using xhci_hcd Oct 08 05:01:31 volumio kernel: usb 1-1.3.1: New USB device found, idVendor=04d9, idProduct=0006, bcdDevice= 1.50 Oct 08 05:01:31 volumio kernel: usb 1-1.3.1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 Oct 08 05:01:31 volumio kernel: usb 1-1.3.1: Product: RPI Wired Keyboard 5 Oct 08 05:01:31 volumio kernel: usb 1-1.3.1: Manufacturer: Oct 08 05:01:31 volumio kernel: input: RPI Wired Keyboard 5 as /devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.3/1-1.3.1/1-1.3.1:1.0/0003:04D9:0006.0005/input/input5 Oct 08 05:01:31 volumio kernel: hid-generic 0003:04D9:0006.0005: input,hidraw0: USB HID v1.11 Keyboard [ RPI Wired Keyboard 5] on usb-0000:01:00.0-1.3.1/input0 Oct 08 05:01:31 volumio kernel: input: RPI Wired Keyboard 5 as /devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.3/1-1.3.1/1-1.3.1:1.1/0003:04D9:0006.0006/input/input6 Oct 08 05:01:31 volumio kernel: hid-generic 0003:04D9:0006.0006: input,hidraw1: USB HID v1.11 Device [ RPI Wired Keyboard 5] on usb-0000:01:00.0-1.3.1/input1 Oct 08 05:01:31 volumio systemd-udevd[14250]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Oct 08 05:01:31 volumio systemd-udevd[14256]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Oct 08 05:01:31 volumio systemd-logind[527]: Watching system buttons on /dev/input/event0 ( RPI Wired Keyboard 5) Oct 08 05:01:32 volumio sudo[14243]: volumio : unable to resolve host volumio Oct 08 05:01:32 volumio sudo[14243]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Oct 08 05:01:33 volumio sudo[14243]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-08 05:00 Oct 08 05:01:33 volumio sudo[14243]: 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:01:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="e0a6dc7e914e3fb93cbf2123f2f73eac"