-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Tue 2025-03-18 10:16:30 CET. -- Mar 18 10:15:00 volumio-markus volumio[955]: info: Setting Geolocation for MyVolumio to eu6 Mar 18 10:15:00 volumio-markus volumio[955]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 18 10:15:00 volumio-markus volumio[955]: info: MRS: Removed streaming files Mar 18 10:15:00 volumio-markus volumio[955]: info: MRS: volumioStreaming STOPPED Mar 18 10:15:00 volumio-markus volumio[955]: info: MRS: SNAPSERVER STOPPED Mar 18 10:15:00 volumio-markus volumio[955]: info: MRS: SNAPCLIENT STOPPED Mar 18 10:15:00 volumio-markus volumio[955]: error: Cannot start Volumio Streaming Daemon Mar 18 10:15:00 volumio-markus volumio[955]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Mar 18 10:15:00 volumio-markus volumio[955]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Mar 18 10:15:00 volumio-markus volumio[955]: info: Asound.conf file written Mar 18 10:15:00 volumio-markus sudo[1360]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Mar 18 10:15:00 volumio-markus sudo[1360]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 10:15:00 volumio-markus sudo[1360]: pam_unix(sudo:session): session closed for user root Mar 18 10:15:00 volumio-markus volumio[955]: info: Output device has changed, restarting MPD Mar 18 10:15:00 volumio-markus sudo[1365]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 18 10:15:00 volumio-markus volumio[955]: info: Output device has changed, restarting Shairport Sync Mar 18 10:15:00 volumio-markus volumio[955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 10:15:00 volumio-markus volumio[955]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 18 10:15:00 volumio-markus sudo[1365]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 10:15:00 volumio-markus sudo[1365]: pam_unix(sudo:session): session closed for user root Mar 18 10:15:00 volumio-markus sudo[1367]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 18 10:15:00 volumio-markus sudo[1367]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 10:15:00 volumio-markus systemd[1]: Stopping Music Player Daemon... Mar 18 10:15:00 volumio-markus volumio[955]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 18 10:15:00 volumio-markus volumio[955]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Mar 18 10:15:00 volumio-markus volumio[955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 10:15:00 volumio-markus systemd[1]: mpd.service: Succeeded. Mar 18 10:15:00 volumio-markus systemd[1]: Stopped Music Player Daemon. Mar 18 10:15:00 volumio-markus volumio[955]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth Mar 18 10:15:00 volumio-markus volumio[955]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 18 10:15:00 volumio-markus volumio[955]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom Mar 18 10:15:00 volumio-markus volumio[955]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Mar 18 10:15:00 volumio-markus volumio[955]: info: MRS: Pushing multiroomSync output for this device Mar 18 10:15:00 volumio-markus volumio[955]: info: MRS: Pushing multiroomSync output Mar 18 10:15:00 volumio-markus volumio[955]: info: Adding audio output: Mar 18 10:15:00 volumio-markus volumio[955]: info: Adding audio output: Mar 18 10:15:00 volumio-markus sudo[1377]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name volumio-markus Mar 18 10:15:00 volumio-markus sudo[1377]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 10:15:00 volumio-markus volumio[955]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Mar 18 10:15:00 volumio-markus volumio[955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 10:15:00 volumio-markus volumio[955]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio Mar 18 10:15:00 volumio-markus volumio[955]: info: Adding METAVOLUMIO REST API Endpoints Mar 18 10:15:00 volumio-markus volumio[955]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Mar 18 10:15:00 volumio-markus volumio[955]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Mar 18 10:15:00 volumio-markus volumio[955]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Mar 18 10:15:00 volumio-markus volumio[955]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Mar 18 10:15:00 volumio-markus volumio[955]: info: [MyVolumio PluginManager] Starting plugin miscellanea.manifestui Mar 18 10:15:00 volumio-markus volumio[955]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller Mar 18 10:15:00 volumio-markus volumio[955]: info: [MyVolumio PluginManager] Plugin cd_controller disabled by user. Not starting Mar 18 10:15:00 volumio-markus volumio[955]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs Mar 18 10:15:00 volumio-markus volumio[955]: info: [MyVolumio PluginManager] Plugin smart_inputs disabled by user. Not starting Mar 18 10:15:00 volumio-markus volumio[955]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio Mar 18 10:15:00 volumio-markus volumio[955]: error: Hi Res Audio Failed Login: Missing Login Data Mar 18 10:15:00 volumio-markus volumio[955]: info: Adding HIGHRESAUDIO REST API Endpoints Mar 18 10:15:00 volumio-markus volumio[955]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Mar 18 10:15:00 volumio-markus volumio[955]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal Mar 18 10:15:00 volumio-markus volumio[955]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz Mar 18 10:15:00 volumio-markus volumio[955]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect Mar 18 10:15:00 volumio-markus volumio[955]: info: [MyVolumio PluginManager] Plugin tidalconnect disabled by user. Not starting Mar 18 10:15:00 volumio-markus sudo[1377]: pam_unix(sudo:session): session closed for user root Mar 18 10:15:00 volumio-markus systemd[1]: Starting Music Player Daemon... Mar 18 10:15:00 volumio-markus volumio[955]: info: Stopping AccessToken refresher cron Mar 18 10:15:00 volumio-markus volumio[955]: info: AccessToken refresher cron started Mar 18 10:15:00 volumio-markus volumio[955]: info: Stopping AccessToken refresher cron for QOBUZ Mar 18 10:15:00 volumio-markus volumio[955]: info: AccessToken refresher cron started for QOBUZ Mar 18 10:15:00 volumio-markus volumio[955]: info: Adding TIDAL REST API Endpoints Mar 18 10:15:00 volumio-markus volumio[955]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal Mar 18 10:15:00 volumio-markus volumio[955]: info: Adding QOBUZ REST API Endpoints Mar 18 10:15:00 volumio-markus volumio[955]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz Mar 18 10:15:00 volumio-markus volumio[955]: info: Bluetooth name changed to volumio-markus Mar 18 10:15:00 volumio-markus volumio[955]: info: MPD Permissions set Mar 18 10:15:00 volumio-markus volumio[955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 10:15:00 volumio-markus sudo[1375]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 18 10:15:00 volumio-markus sudo[1375]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 10:15:00 volumio-markus volumio[955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 10:15:00 volumio-markus volumio[955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 10:15:00 volumio-markus volumio[955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 10:15:00 volumio-markus volumio[955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 10:15:00 volumio-markus volumio[955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 10:15:00 volumio-markus volumio[955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 10:15:00 volumio-markus volumio[955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 10:15:00 volumio-markus sudo[1375]: pam_unix(sudo:session): session closed for user root Mar 18 10:15:00 volumio-markus volumio[955]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 18 10:15:00 volumio-markus volumio[955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 10:15:00 volumio-markus volumio[955]: [Metrics] CommandRouter: 19s 227.12ms Mar 18 10:15:00 volumio-markus volumio[955]: info: CoreCommandRouter::volumiosetStartupVolume Mar 18 10:15:00 volumio-markus volumio[955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 10:15:00 volumio-markus volumio[955]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 18 10:15:00 volumio-markus volumio[955]: info: CoreCommandRouter::Close All Modals sent Mar 18 10:15:00 volumio-markus volumio[955]: info: CoreCommandRouter::Close All Modals sent Mar 18 10:15:00 volumio-markus volumio[955]: info: Starting Shairport Sync Mar 18 10:15:00 volumio-markus sudo[1391]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 18 10:15:00 volumio-markus sudo[1391]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 10:15:00 volumio-markus systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 18 10:15:00 volumio-markus systemd[1]: shairport-sync.service: Succeeded. Mar 18 10:15:00 volumio-markus systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 18 10:15:00 volumio-markus systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 18 10:15:00 volumio-markus sudo[1391]: pam_unix(sudo:session): session closed for user root Mar 18 10:15:00 volumio-markus volumio[955]: info: Shairport-Sync Started Mar 18 10:15:00 volumio-markus volumio[955]: info: Successfully Added MyVolumio device Mar 18 10:15:00 volumio-markus volumio[955]: info: Successfully Added MyVolumio device Mar 18 10:15:00 volumio-markus volumio[955]: info: Updating MyVolumio device info Mar 18 10:15:00 volumio-markus volumio[955]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 18 10:15:00 volumio-markus volumio[955]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 18 10:15:00 volumio-markus volumio[955]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 18 10:15:01 volumio-markus volumio[955]: info: Updating MyVolumio device info Mar 18 10:15:01 volumio-markus volumio[955]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 18 10:15:01 volumio-markus volumio[955]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 18 10:15:01 volumio-markus volumio[955]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 18 10:15:01 volumio-markus mpd[1383]: Mar 18 10:15 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 18 10:15:01 volumio-markus systemd[1]: Started Music Player Daemon. Mar 18 10:15:01 volumio-markus sudo[1367]: pam_unix(sudo:session): session closed for user root Mar 18 10:15:01 volumio-markus volumio[955]: error: updateQueue error: null Mar 18 10:15:01 volumio-markus volumio[955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Mar 18 10:15:01 volumio-markus volumio[955]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 18 10:15:01 volumio-markus volumio[955]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Mar 18 10:15:01 volumio-markus volumio[955]: info: Successfully Updated MyVolumio device Mar 18 10:15:02 volumio-markus volumio[955]: info: Successfully Updated MyVolumio device Mar 18 10:15:03 volumio-markus sudo[1405]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Mar 18 10:15:03 volumio-markus sudo[1405]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 10:15:03 volumio-markus systemd[1]: Started MyVolumio SSH Tunnel. Mar 18 10:15:03 volumio-markus sudo[1405]: pam_unix(sudo:session): session closed for user root Mar 18 10:15:03 volumio-markus volumio[955]: info: Remote SSH Started Mar 18 10:15:03 volumio-markus autossh[1408]: port set to 0, monitoring disabled Mar 18 10:15:03 volumio-markus autossh[1408]: starting ssh (count 1) Mar 18 10:15:03 volumio-markus autossh[1408]: ssh child pid is 1411 Mar 18 10:15:03 volumio-markus sudo[1427]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Mar 18 10:15:03 volumio-markus sudo[1427]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 10:15:03 volumio-markus volumiossh-tunnel[1407]: Warning: Permanently added '[eu6.myvolumio.org]:2222,[207.154.233.230]:2222' (RSA) to the list of known hosts. Mar 18 10:15:03 volumio-markus volumio[955]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Mar 18 10:15:03 volumio-markus volumio[955]: info: CoreCommandRouter::volumioGetState Mar 18 10:15:03 volumio-markus volumio[955]: info: CorePlayQueue::getTrack 0 Mar 18 10:15:03 volumio-markus systemd[1]: Started Volumio Bluetooth Module. Mar 18 10:15:03 volumio-markus sudo[1427]: pam_unix(sudo:session): session closed for user root Mar 18 10:15:03 volumio-markus volumio[955]: info: Volumio BT Module successfully started Mar 18 10:15:03 volumio-markus sudo[1430]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/* Mar 18 10:15:03 volumio-markus sudo[1430]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 10:15:03 volumio-markus volumiobt[1429]: /bin/chmod: cannot access '/var/lib/bluetooth/*': No such file or directory Mar 18 10:15:03 volumio-markus sudo[1430]: pam_unix(sudo:session): session closed for user root Mar 18 10:15:04 volumio-markus sudo[1436]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio Mar 18 10:15:04 volumio-markus sudo[1436]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 10:15:04 volumio-markus volumiobt[1429]: pulseaudio: no process found Mar 18 10:15:04 volumio-markus sudo[1436]: pam_unix(sudo:session): session closed for user root Mar 18 10:15:04 volumio-markus dbus-daemon[576]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' requested by ':1.20' (uid=1000 pid=1440 comm="/usr/bin/pulseaudio --high-priority=true ") Mar 18 10:15:04 volumio-markus systemd[1]: Starting RealtimeKit Scheduling Policy Service... Mar 18 10:15:04 volumio-markus volumio[955]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 18 10:15:04 volumio-markus dbus-daemon[576]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1' Mar 18 10:15:04 volumio-markus systemd[1]: Started RealtimeKit Scheduling Policy Service. Mar 18 10:15:04 volumio-markus rtkit-daemon[1441]: Successfully called chroot. Mar 18 10:15:04 volumio-markus rtkit-daemon[1441]: Successfully dropped privileges. Mar 18 10:15:04 volumio-markus rtkit-daemon[1441]: Successfully limited resources. Mar 18 10:15:04 volumio-markus rtkit-daemon[1441]: Running. Mar 18 10:15:04 volumio-markus rtkit-daemon[1441]: Canary thread running. Mar 18 10:15:04 volumio-markus dbus-daemon[576]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.21' (uid=0 pid=1441 comm="/usr/lib/rtkit/rtkit-daemon ") Mar 18 10:15:04 volumio-markus rtkit-daemon[1441]: Watchdog thread running. Mar 18 10:15:04 volumio-markus systemd[1]: Starting Authorization Manager... Mar 18 10:15:04 volumio-markus volumio[955]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 18 10:15:04 volumio-markus polkitd[1445]: started daemon version 0.105 using authority implementation `local' version `0.105' Mar 18 10:15:04 volumio-markus dbus-daemon[576]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Mar 18 10:15:04 volumio-markus systemd[1]: Started Authorization Manager. Mar 18 10:15:04 volumio-markus pulseaudio[1440]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Mar 18 10:15:04 volumio-markus pulseaudio[1440]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Mar 18 10:15:04 volumio-markus bluetoothd[700]: Endpoint registered: sender=:1.41 path=/MediaEndpoint/A2DPSource Mar 18 10:15:04 volumio-markus bluetoothd[700]: Endpoint registered: sender=:1.41 path=/MediaEndpoint/A2DPSink Mar 18 10:15:04 volumio-markus volumiobt[1429]: Applying permissions Mar 18 10:15:04 volumio-markus volumiobt[1429]: Setting BT discoverable and pairable Mar 18 10:15:04 volumio-markus pulseaudio[1440]: Failed to register as a handsfree audio agent with ofono: org.freedesktop.DBus.Error.ServiceUnknown: The name org.ofono was not provided by any .service files Mar 18 10:15:04 volumio-markus kernel: Bluetooth: RFCOMM TTY layer initialized Mar 18 10:15:04 volumio-markus kernel: Bluetooth: RFCOMM socket layer initialized Mar 18 10:15:04 volumio-markus kernel: Bluetooth: RFCOMM ver 1.11 Mar 18 10:15:04 volumio-markus volumiobt[1429]: Agent registered Mar 18 10:15:04 volumio-markus volumiobt[1429]: [bluetooth]# -e power on Mar 18 10:15:04 volumio-markus volumiobt[1429]: Invalid command in menu main: -e Mar 18 10:15:04 volumio-markus volumiobt[1429]: Mar 18 10:15:04 volumio-markus volumiobt[1429]: Use "help" for a list of available commands in a menu. Mar 18 10:15:04 volumio-markus volumiobt[1429]: Use "menu " if you want to enter any submenu. Mar 18 10:15:04 volumio-markus volumiobt[1429]: Use "back" if you want to return to menu main. Mar 18 10:15:04 volumio-markus volumiobt[1429]: [bluetooth]# agent on Mar 18 10:15:04 volumio-markus volumiobt[1429]: Agent is already registered Mar 18 10:15:04 volumio-markus volumiobt[1429]: [bluetooth]# discoverable on Mar 18 10:15:04 volumio-markus volumiobt[1429]: [bluetooth]# pairable on Mar 18 10:15:04 volumio-markus volumiobt[1429]: [bluetooth]# agent NoInputNoOutput Mar 18 10:15:04 volumio-markus volumiobt[1429]: Agent is already registered Mar 18 10:15:04 volumio-markus volumiobt[1429]: [bluetooth]# default-agent Mar 18 10:15:04 volumio-markus volumiobt[1429]: [bluetooth]# quit Mar 18 10:15:04 volumio-markus volumiobt[1429]: [59B blob data] Mar 18 10:15:05 volumio-markus volumio[955]: info: MRS: Getting audio outputs on start Mar 18 10:15:05 volumio-markus volumio[955]: info: MRS: Requesting all other devices output Mar 18 10:15:05 volumio-markus kernel: xhci_hcd 0000:01:00.0: ERROR Transfer event for disabled endpoint slot 2 ep 1 Mar 18 10:15:05 volumio-markus kernel: xhci_hcd 0000:01:00.0: @0000000429522d60 00000000 00000000 0e000000 02028001 Mar 18 10:15:07 volumio-markus volumio[955]: info: BOOT COMPLETED Mar 18 10:15:10 volumio-markus volumio[955]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 18 10:15:10 volumio-markus volumio[955]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Mar 18 10:15:10 volumio-markus volumio[955]: info: CoreCommandRouter::volumioGetState Mar 18 10:15:10 volumio-markus volumio[955]: info: CorePlayQueue::getTrack 0 Mar 18 10:15:11 volumio-markus systemd[1]: systemd-timedated.service: Succeeded. Mar 18 10:15:15 volumio-markus volumio[955]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 18 10:15:15 volumio-markus volumio[955]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 18 10:15:15 volumio-markus volumio[955]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 18 10:15:15 volumio-markus volumio[955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 10:15:15 volumio-markus volumio[955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 10:15:15 volumio-markus volumio[955]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Mar 18 10:15:15 volumio-markus volumio[955]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Mar 18 10:15:15 volumio-markus volumio[955]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Mar 18 10:15:15 volumio-markus volumio[955]: info: CoreCommandRouter::volumioGetBrowseSources Mar 18 10:15:15 volumio-markus volumio[955]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 18 10:15:15 volumio-markus volumio-remote-updater[607]: No test mode Mar 18 10:15:15 volumio-markus volumio-remote-updater[607]: No alpha test mode Mar 18 10:15:15 volumio-markus volumio[955]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Mar 18 10:15:15 volumio-markus volumio[955]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Mar 18 10:15:15 volumio-markus volumio[955]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 18 10:15:28 volumio-markus ntpd[742]: Soliciting pool server 185.252.140.126 Mar 18 10:15:28 volumio-markus ntpd[742]: Soliciting pool server 194.59.205.229 Mar 18 10:15:29 volumio-markus ntpd[742]: Soliciting pool server 167.235.139.237 Mar 18 10:15:29 volumio-markus ntpd[742]: Soliciting pool server 167.235.69.67 Mar 18 10:15:29 volumio-markus ntpd[742]: Soliciting pool server 217.144.138.234 Mar 18 10:15:29 volumio-markus ntpd[742]: Soliciting pool server 178.63.52.50 Mar 18 10:15:30 volumio-markus ntpd[742]: Soliciting pool server 78.46.53.2 Mar 18 10:15:30 volumio-markus ntpd[742]: Soliciting pool server 129.70.132.34 Mar 18 10:15:30 volumio-markus ntpd[742]: Soliciting pool server 168.119.211.223 Mar 18 10:15:30 volumio-markus ntpd[742]: Soliciting pool server 5.189.151.39 Mar 18 10:15:31 volumio-markus ntpd[742]: Soliciting pool server 62.108.36.235 Mar 18 10:15:31 volumio-markus ntpd[742]: Soliciting pool server 51.75.67.47 Mar 18 10:15:31 volumio-markus ntpd[742]: Soliciting pool server 85.214.133.14 Mar 18 10:15:32 volumio-markus ntpd[742]: Soliciting pool server 85.215.166.214 Mar 18 10:15:32 volumio-markus ntpd[742]: Soliciting pool server 2001:41d0:700:49bc::6 Mar 18 10:15:32 volumio-markus ntpd[742]: Soliciting pool server 79.133.44.143 Mar 18 10:15:35 volumio-markus ntpd[742]: receive: Unexpected origin timestamp 0xeb83b837.2d2b54b6 does not match aorg 0000000000.00000000 from server@85.215.166.214 xmt 0xeb83b837.b972d87e Mar 18 10:16:17 volumio-markus wpa_supplicant[854]: RRM: Ignoring radio measurement request: Not RRM network Mar 18 10:16:19 volumio-markus wpa_supplicant[854]: RRM: Ignoring radio measurement request: Not RRM network Mar 18 10:16:21 volumio-markus volumio[955]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 18 10:16:21 volumio-markus volumio[955]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 18 10:16:21 volumio-markus volumio[955]: info: Retrieving Cloud Streaming UI Mar 18 10:16:21 volumio-markus volumio[955]: info: Getting Tidal Cloud Configuration Mar 18 10:16:21 volumio-markus volumio[955]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 18 10:16:21 volumio-markus volumio[955]: info: Getting Qobuz Cloud Configuration Mar 18 10:16:21 volumio-markus volumio[955]: info: Asking plugin for UI Config Mar 18 10:16:21 volumio-markus volumio[955]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 18 10:16:21 volumio-markus volumio[955]: info: Getting Spotify Cloud Configuration Mar 18 10:16:21 volumio-markus volumio[955]: info: Asking plugin for UI Config Mar 18 10:16:21 volumio-markus volumio[955]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 18 10:16:21 volumio-markus volumio[955]: info: Saving Spotify Acccount Mar 18 10:16:21 volumio-markus volumio[955]: info: Got it Mar 18 10:16:21 volumio-markus volumio[955]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Mar 18 10:16:21 volumio-markus volumio[955]: info: Got Tidal Cloud Configuration Mar 18 10:16:21 volumio-markus volumio[955]: info: Got it Mar 18 10:16:21 volumio-markus volumio[955]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 18 10:16:21 volumio-markus volumio[955]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 18 10:16:21 volumio-markus volumio[955]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 18 10:16:21 volumio-markus volumio[955]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 18 10:16:21 volumio-markus volumio[955]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 18 10:16:21 volumio-markus volumio[955]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 18 10:16:21 volumio-markus volumio[955]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 18 10:16:21 volumio-markus volumio[955]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 18 10:16:21 volumio-markus volumio[955]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 18 10:16:21 volumio-markus volumio[955]: info: CoreCommandRouter::volumioGetBrowseSources Mar 18 10:16:21 volumio-markus volumio[955]: info: CoreCommandRouter::volumioGetBrowseSources Mar 18 10:16:21 volumio-markus volumio[955]: info: CoreCommandRouter::volumioGetBrowseSources Mar 18 10:16:21 volumio-markus volumio[955]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 18 10:16:21 volumio-markus volumio[955]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Mar 18 10:16:21 volumio-markus wpa_supplicant[854]: RRM: Ignoring radio measurement request: Not RRM network Mar 18 10:16:25 volumio-markus volumio[955]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 18 10:16:29 volumio-markus volumio[955]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 18 10:16:29 volumio-markus volumio[955]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare Mar 18 10:16:29 volumio-markus sudo[1670]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount /mnt/NAS/media Mar 18 10:16:29 volumio-markus sudo[1670]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 10:16:29 volumio-markus sudo[1670]: pam_unix(sudo:session): session closed for user root Mar 18 10:16:29 volumio-markus volumio[955]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 18 10:16:29 volumio-markus volumio[955]: Error: EBUSY: resource busy or locked, rmdir '/mnt/NAS/media' Mar 18 10:16:29 volumio-markus volumio[955]: at Object.rmdirSync (fs.js:890:10) Mar 18 10:16:29 volumio-markus volumio[955]: at /volumio/node_modules/linux-mountutils/mountutils.js:178:12 Mar 18 10:16:29 volumio-markus volumio[955]: at ChildProcess.exithandler (child_process.js:299:7) Mar 18 10:16:29 volumio-markus volumio[955]: at ChildProcess.emit (events.js:315:20) Mar 18 10:16:29 volumio-markus volumio[955]: at maybeClose (internal/child_process.js:1048:16) Mar 18 10:16:29 volumio-markus volumio[955]: at Socket. (internal/child_process.js:439:11) Mar 18 10:16:29 volumio-markus volumio[955]: at Socket.emit (events.js:315:20) Mar 18 10:16:29 volumio-markus volumio[955]: at Pipe. (net.js:673:12) { Mar 18 10:16:29 volumio-markus volumio[955]: errno: -16, Mar 18 10:16:29 volumio-markus volumio[955]: syscall: 'rmdir', Mar 18 10:16:29 volumio-markus volumio[955]: code: 'EBUSY', Mar 18 10:16:29 volumio-markus volumio[955]: path: '/mnt/NAS/media' Mar 18 10:16:29 volumio-markus volumio[955]: } Mar 18 10:16:29 volumio-markus volumio[955]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 18 10:16:30 volumio-markus sudo[1682]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-18 10:15 Mar 18 10:16:30 volumio-markus sudo[1682]: 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="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="a01a833dd28483f88cb390596f5090b7187992af" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 27 Feb 2025 11:42:54 AM CET" VOLUMIO_VERSION="3.795" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="4049a67f1c09d4a94e033ba35a80a144"