-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Tue 2025-09-16 20:33:36 CEST. -- Sep 16 20:32:48 volumio systemd-timedated[1031]: Changed local time to Tue Sep 16 20:32:48 2025 Sep 16 20:32:48 volumio sudo[1015]: pam_unix(sudo:session): session closed for user root Sep 16 20:32:48 volumio volumio-time-update[614]: volumio-time-update-util: System time updated successfully. Sep 16 20:32:48 volumio systemd[1]: Started Volumio Time Update Utility. Sep 16 20:32:48 volumio systemd[1]: Reached target Multi-User System. Sep 16 20:32:48 volumio systemd[1]: Reached target Graphical Interface. Sep 16 20:32:48 volumio avahi-daemon[636]: Withdrawing address record for 192.168.211.1 on wlan0. Sep 16 20:32:48 volumio avahi-daemon[636]: Host name conflict, retrying with volumio-2 Sep 16 20:32:48 volumio avahi-daemon[636]: Registering new address record for 192.168.211.1 on wlan0.IPv4. Sep 16 20:32:48 volumio avahi-daemon[636]: Registering new address record for 192.168.28.151 on eth0.IPv4. Sep 16 20:32:48 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Sep 16 20:32:48 volumio systemd[1]: Starting Daily apt download activities... Sep 16 20:32:48 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Sep 16 20:32:48 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Sep 16 20:32:48 volumio ntpd[786]: Listen normally on 4 eth0 192.168.28.151:123 Sep 16 20:32:48 volumio ntpd[786]: new interface(s) found: waking up resolver Sep 16 20:32:48 volumio avahi-daemon[636]: Server startup complete. Host name is volumio-2.local. Local service cookie is 4156179877. Sep 16 20:32:49 volumio volumio[898]: info: Loading plugin "network"... Sep 16 20:32:49 volumio volumio[898]: info: Refreshing Cached IP Addresses Sep 16 20:32:49 volumio sudo[1057]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 16 20:32:49 volumio sudo[1057]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 20:32:49 volumio sudo[1057]: pam_unix(sudo:session): session closed for user root Sep 16 20:32:49 volumio sudo[1059]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 16 20:32:49 volumio sudo[1059]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 20:32:49 volumio sudo[1059]: pam_unix(sudo:session): session closed for user root Sep 16 20:32:49 volumio volumio[898]: info: Loading plugin "services"... Sep 16 20:32:49 volumio volumio[898]: info: Loading plugin "alsa_controller"... Sep 16 20:32:49 volumio volumio-remote-updater[607]: [2025-09-16 20:32:49] [connect] Successful connection Sep 16 20:32:49 volumio sudo[1068]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Sep 16 20:32:49 volumio sudo[1068]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 20:32:50 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 16 20:32:50 volumio volumio[898]: info: Loading plugin "wizard"... Sep 16 20:32:50 volumio volumio[898]: info: Loading plugin "networkfs"... Sep 16 20:32:50 volumio volumio[898]: info: Starting Udev Watcher for removable devices Sep 16 20:32:50 volumio volumio[898]: info: Ignoring mount for partition: boot Sep 16 20:32:50 volumio volumio[898]: info: Ignoring mount for partition: volumio Sep 16 20:32:50 volumio volumio[898]: info: Ignoring mount for partition: volumio_data Sep 16 20:32:50 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 16 20:32:50 volumio volumio[898]: info: Loading plugin "volumio_command_line_client"... Sep 16 20:32:50 volumio volumio[898]: info: Loading plugin "upnp"... Sep 16 20:32:50 volumio volumio[898]: info: [1758047570251] Starting Upmpd Daemon Sep 16 20:32:50 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 16 20:32:50 volumio volumio[898]: info: Loading plugin "my_music"... Sep 16 20:32:50 volumio volumio[898]: info: Loading plugin "mpd"... Sep 16 20:32:50 volumio sudo[1068]: pam_unix(sudo:session): session closed for user root Sep 16 20:32:50 volumio volumio[898]: info: Loading plugin "upnp_browser"... Sep 16 20:32:51 volumio volumio[898]: info: Loading plugin "alarm-clock"... Sep 16 20:32:51 volumio volumio[898]: info: Loading plugin "airplay_emulation"... Sep 16 20:32:51 volumio volumio[898]: info: Starting Shairport Sync Sep 16 20:32:51 volumio volumio[898]: info: Loading plugin "last_100"... Sep 16 20:32:51 volumio volumio[898]: info: Loading plugin "webradio"... Sep 16 20:32:52 volumio volumio[898]: info: Loading plugin "i2s_dacs"... Sep 16 20:32:52 volumio volumio[898]: info: Loading plugin "volumiodiscovery"... Sep 16 20:32:52 volumio systemd[1]: apt-daily.service: Succeeded. Sep 16 20:32:52 volumio systemd[1]: Started Daily apt download activities. Sep 16 20:32:52 volumio volumio[898]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Sep 16 20:32:52 volumio volumio[898]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 16 20:32:52 volumio volumio[898]: *** WARNING *** For more information see Sep 16 20:32:52 volumio volumio[898]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Sep 16 20:32:52 volumio node[898]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Sep 16 20:32:52 volumio volumio[898]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 16 20:32:52 volumio volumio[898]: *** WARNING *** For more information see Sep 16 20:32:52 volumio node[898]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 16 20:32:52 volumio node[898]: *** WARNING *** For more information see Sep 16 20:32:52 volumio node[898]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Sep 16 20:32:52 volumio node[898]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 16 20:32:52 volumio node[898]: *** WARNING *** For more information see Sep 16 20:32:52 volumio volumio[898]: info: Applying required configuration parameters for plugin volumiodiscovery Sep 16 20:32:52 volumio systemd[1]: Starting Daily apt upgrade and clean activities... Sep 16 20:32:52 volumio volumio[898]: info: Discovery: Started advertising with name: Volumio Sep 16 20:32:52 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 16 20:32:52 volumio volumio[898]: info: Loading plugin "outputs"... Sep 16 20:32:52 volumio volumio[898]: info: Loading plugin "albumart"... Sep 16 20:32:52 volumio volumio[898]: info: Plugin example_plugin is not enabled Sep 16 20:32:52 volumio volumio[898]: info: Loading plugin "inputs"... Sep 16 20:32:52 volumio volumio[898]: info: Loading plugin "updater_comm"... Sep 16 20:32:52 volumio kernel: usb 1-1.3: USB disconnect, device number 4 Sep 16 20:32:53 volumio kernel: usb 1-1.3.1: USB disconnect, device number 5 Sep 16 20:32:53 volumio kernel: usb 1-1.3.2: USB disconnect, device number 6 Sep 16 20:32:53 volumio thd[631]: Error reading device '/dev/input/event0' Sep 16 20:32:53 volumio thd[631]: Error reading device '/dev/input/event1' Sep 16 20:32:53 volumio thd[631]: Error reading device '/dev/input/event2' Sep 16 20:32:53 volumio thd[631]: Error reading device '/dev/input/event3' Sep 16 20:32:53 volumio volumio[898]: info: Plugin mpdemulation is not enabled Sep 16 20:32:53 volumio volumio[898]: info: Loading plugin "rest_api"... Sep 16 20:32:53 volumio volumio[898]: info: Loading plugin "websocket"... Sep 16 20:32:53 volumio volumio[898]: info: Starting Socket.io Server version 2.3.0 Sep 16 20:32:53 volumio volumio[898]: Forking 3 albumart workers Sep 16 20:32:53 volumio volumio[898]: info: Loading i18n strings for locale de Sep 16 20:32:53 volumio volumio[898]: Updating browse sources language Sep 16 20:32:53 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 16 20:32:53 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 16 20:32:53 volumio volumio[898]: info: CoreCommandRouter::initPlayerControls Sep 16 20:32:53 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 20:32:53 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 16 20:32:53 volumio volumio[898]: Express server listening on port 3000 Sep 16 20:32:53 volumio volumio[898]: [Metrics] WebUI: 8s 758.49ms Sep 16 20:32:53 volumio volumio[898]: info: CoreStateMachine::resetVolumioState Sep 16 20:32:53 volumio volumio[898]: info: CoreStateMachine::getcurrentVolume Sep 16 20:32:53 volumio volumio[898]: info: CoreCommandRouter::volumioRetrievevolume Sep 16 20:32:53 volumio volumio[898]: info: Cannot read play queue from file Sep 16 20:32:53 volumio volumio[898]: info: Volumio Network Manager: Network status updated: 1 Sep 16 20:32:53 volumio volumio-remote-updater[607]: [2025-09-16 20:32:53] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1758047569 101 Sep 16 20:32:53 volumio volumio[898]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 1 Sep 16 20:32:53 volumio volumio[898]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Sep 16 20:32:53 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 20:32:53 volumio volumio[898]: info: CoreStateMachine::setRepeat null single undefined Sep 16 20:32:53 volumio volumio[898]: info: CoreStateMachine::pushState Sep 16 20:32:53 volumio volumio[898]: info: CorePlayQueue::getTrack 0 Sep 16 20:32:53 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 16 20:32:53 volumio volumio[898]: info: CoreCommandRouter::volumioPushState Sep 16 20:32:53 volumio volumio[898]: info: CoreStateMachine::setRandom null Sep 16 20:32:53 volumio volumio[898]: info: CoreStateMachine::pushState Sep 16 20:32:53 volumio volumio[898]: info: CorePlayQueue::getTrack 0 Sep 16 20:32:53 volumio volumio[898]: info: CoreCommandRouter::volumioPushState Sep 16 20:32:53 volumio volumio[898]: info: Setting Device type: Raspberry PI Sep 16 20:32:53 volumio volumio[898]: info: VolumeController:: Volume=undefined Mute =false Sep 16 20:32:53 volumio volumio[898]: info: CoreStateMachine::pushState Sep 16 20:32:53 volumio volumio[898]: info: CorePlayQueue::getTrack 0 Sep 16 20:32:53 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 16 20:32:53 volumio volumio[898]: info: CoreCommandRouter::volumioPushState Sep 16 20:32:54 volumio volumio[898]: info: CoreStateMachine::updateTrackBlock Sep 16 20:32:54 volumio volumio[898]: info: CorePlayQueue::getTrackBlock Sep 16 20:32:54 volumio volumio[898]: info: CoreCommandRouter::volumioRetrievevolume Sep 16 20:32:54 volumio volumio[898]: info: Completed loading Core Plugins Sep 16 20:32:54 volumio volumio[898]: info: Preparing to generate the ALSA configuration file Sep 16 20:32:54 volumio volumio[898]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Sep 16 20:32:54 volumio volumio[898]: info: Asound.conf file unchanged, so no further update is needed Sep 16 20:32:54 volumio volumio[898]: info: Output device has changed, restarting MPD Sep 16 20:32:54 volumio sudo[1185]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 16 20:32:54 volumio sudo[1185]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 20:32:54 volumio sudo[1185]: pam_unix(sudo:session): session closed for user root Sep 16 20:32:54 volumio volumio[898]: info: Output device has changed, restarting Shairport Sync Sep 16 20:32:54 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 20:32:54 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 20:32:54 volumio sudo[1190]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 16 20:32:54 volumio sudo[1190]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 20:32:54 volumio systemd[1]: Stopping Music Player Daemon... Sep 16 20:32:54 volumio volumio[898]: Starting albumart workers Sep 16 20:32:54 volumio volumio[898]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 16 20:32:54 volumio volumio[898]: info: ___________ START PLUGINS ___________ Sep 16 20:32:54 volumio volumio[898]: info: ControllerMpd::onStart: Initializing MPD Sep 16 20:32:54 volumio volumio[898]: info: Creating MPD Configuration file Sep 16 20:32:54 volumio volumio[898]: Starting albumart workers Sep 16 20:32:54 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 16 20:32:54 volumio volumio[898]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 16 20:32:54 volumio volumio[898]: info: [1758047574541] CoreMusicLibrary::Adding element Medienserver Sep 16 20:32:54 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 16 20:32:54 volumio systemd[1]: mpd.service: Succeeded. Sep 16 20:32:54 volumio systemd[1]: Stopped Music Player Daemon. Sep 16 20:32:54 volumio sudo[1204]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 16 20:32:54 volumio sudo[1204]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 20:32:54 volumio sudo[1207]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 16 20:32:54 volumio sudo[1207]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 20:32:54 volumio systemd[1]: Starting Music Player Daemon... Sep 16 20:32:54 volumio sudo[1204]: pam_unix(sudo:session): session closed for user root Sep 16 20:32:54 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 20:32:54 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 20:32:54 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Sep 16 20:32:54 volumio systemd[1]: mpd.service: Succeeded. Sep 16 20:32:54 volumio systemd[1]: Stopped Music Player Daemon. Sep 16 20:32:54 volumio systemd[1]: Starting Music Player Daemon... Sep 16 20:32:54 volumio volumio[898]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 16 20:32:54 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 20:32:54 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 20:32:54 volumio volumio[898]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 16 20:32:54 volumio volumio[898]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 16 20:32:54 volumio volumio[898]: info: [1758047574855] CoreMusicLibrary::Adding element Last_100 Sep 16 20:32:54 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 16 20:32:54 volumio systemd[1]: apt-daily-upgrade.service: Succeeded. Sep 16 20:32:54 volumio systemd[1]: Started Daily apt upgrade and clean activities. Sep 16 20:32:54 volumio volumio[898]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 16 20:32:54 volumio volumio[898]: info: [1758047574878] CoreMusicLibrary::Adding element Webradio Sep 16 20:32:54 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 16 20:32:54 volumio sudo[1220]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Sep 16 20:32:54 volumio sudo[1220]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 20:32:54 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 16 20:32:54 volumio sudo[1220]: pam_unix(sudo:session): session closed for user root Sep 16 20:32:54 volumio volumio[898]: info: Initializing BBC Radios Sep 16 20:32:54 volumio volumio[898]: Starting albumart workers Sep 16 20:32:55 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 16 20:32:55 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 20:32:55 volumio volumio[898]: info: Volumio Calling Home Sep 16 20:32:55 volumio volumio[898]: info: Discovery: adding 80517850-01f2-48ff-bd1c-7ea9a22ce3f2 Sep 16 20:32:55 volumio volumio[898]: info: Discovery: Found device Volumio Sep 16 20:32:55 volumio volumio[898]: info: CoreCommandRouter::volumioGetState Sep 16 20:32:55 volumio volumio[898]: info: CorePlayQueue::getTrack 0 Sep 16 20:32:55 volumio volumio[898]: info: Discovery: this is already registered, 80517850-01f2-48ff-bd1c-7ea9a22ce3f2 Sep 16 20:32:55 volumio volumio[898]: info: Discovery: Found device Volumio Sep 16 20:32:55 volumio volumio[898]: info: CoreCommandRouter::volumioGetState Sep 16 20:32:55 volumio volumio[898]: info: CorePlayQueue::getTrack 0 Sep 16 20:32:55 volumio volumio[898]: info: MPD Permissions set Sep 16 20:32:55 volumio volumio[898]: info: MPD Permissions set Sep 16 20:32:55 volumio volumio[898]: info: VolumeController:: Volume=undefined Mute =false Sep 16 20:32:55 volumio volumio[898]: info: CoreStateMachine::pushState Sep 16 20:32:55 volumio volumio[898]: info: CorePlayQueue::getTrack 0 Sep 16 20:32:55 volumio volumio[898]: info: CoreCommandRouter::volumioPushState Sep 16 20:32:55 volumio volumio[898]: info: Volumio called home Sep 16 20:32:55 volumio volumio[898]: error: error Sep 16 20:32:55 volumio volumio[898]: error: error Sep 16 20:32:55 volumio volumio[898]: error: error Sep 16 20:32:55 volumio volumio[898]: error: error Sep 16 20:32:55 volumio volumio[898]: error: error Sep 16 20:32:55 volumio volumio[898]: error: error Sep 16 20:32:55 volumio volumio[898]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Sep 16 20:32:55 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 20:32:55 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 20:32:55 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 20:32:55 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 20:32:55 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 20:32:55 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 20:32:55 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 20:32:55 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 20:32:55 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 20:32:55 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 20:32:56 volumio volumio[898]: error: error Sep 16 20:32:56 volumio volumio[898]: error: error Sep 16 20:32:56 volumio volumio[898]: error: error Sep 16 20:32:56 volumio volumio[898]: error: error Sep 16 20:32:56 volumio volumio[898]: error: error Sep 16 20:32:56 volumio volumio[898]: error: error Sep 16 20:32:56 volumio volumio[898]: info: Starting Shairport Sync Sep 16 20:32:56 volumio volumio[898]: info: Starting Shairport Sync Sep 16 20:32:56 volumio volumio[898]: info: Starting Shairport Sync Sep 16 20:32:56 volumio sudo[1278]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 16 20:32:56 volumio sudo[1278]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 20:32:56 volumio sudo[1280]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 16 20:32:56 volumio sudo[1280]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 20:32:56 volumio sudo[1283]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 16 20:32:56 volumio sudo[1283]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 20:32:56 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Sep 16 20:32:56 volumio systemd[1]: shairport-sync.service: Succeeded. Sep 16 20:32:56 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Sep 16 20:32:56 volumio volumio[898]: info: CoreCommandRouter::volumioGetState Sep 16 20:32:56 volumio volumio[898]: info: CorePlayQueue::getTrack 0 Sep 16 20:32:56 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 16 20:32:56 volumio sudo[1278]: pam_unix(sudo:session): session closed for user root Sep 16 20:32:56 volumio sudo[1280]: pam_unix(sudo:session): session closed for user root Sep 16 20:32:56 volumio sudo[1283]: pam_unix(sudo:session): session closed for user root Sep 16 20:32:56 volumio volumio[898]: info: Shairport-Sync Started Sep 16 20:32:56 volumio volumio[898]: Error adding Membership: Error: addMembership EINVAL Sep 16 20:32:56 volumio volumio[898]: info: Shairport-Sync Started Sep 16 20:32:56 volumio volumio[898]: info: Shairport-Sync Started Sep 16 20:32:57 volumio mpd[1231]: Sep 16 20:32 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Sep 16 20:32:57 volumio systemd[1]: Started Music Player Daemon. Sep 16 20:32:57 volumio systemd[1]: Startup finished in 13.837s (kernel) + 26.172s (userspace) = 40.010s. Sep 16 20:32:57 volumio sudo[1207]: pam_unix(sudo:session): session closed for user root Sep 16 20:32:57 volumio sudo[1190]: pam_unix(sudo:session): session closed for user root Sep 16 20:32:57 volumio volumio[898]: info: Completed starting Core Plugins Sep 16 20:32:57 volumio volumio[898]: info: ------------------------------------------- Sep 16 20:32:57 volumio volumio[898]: info: ----- MyVolumio plugins startup ---- Sep 16 20:32:57 volumio volumio[898]: info: ------------------------------------------- Sep 16 20:32:57 volumio volumio[898]: info: [MyVolumio PluginManager] Fetching plans data.... Sep 16 20:32:57 volumio volumio[898]: error: MPD error: The expression evaluated to a falsy value: Sep 16 20:32:57 volumio volumio[898]: assert.ok(self.idling) Sep 16 20:32:57 volumio volumio[898]: error: The expression evaluated to a falsy value: Sep 16 20:32:57 volumio volumio[898]: assert.ok(self.idling) Sep 16 20:32:57 volumio volumio[898]: info: MPD running with PID1231 Sep 16 20:32:57 volumio volumio[898]: ,establishing connection Sep 16 20:32:57 volumio volumio[898]: error: MPD error: The expression evaluated to a falsy value: Sep 16 20:32:57 volumio volumio[898]: assert.ok(self.idling) Sep 16 20:32:57 volumio volumio[898]: error: The expression evaluated to a falsy value: Sep 16 20:32:57 volumio volumio[898]: assert.ok(self.idling) Sep 16 20:32:57 volumio volumio[898]: error: updateQueue error: null Sep 16 20:32:59 volumio volumio[898]: error: error Sep 16 20:32:59 volumio volumio[898]: error: error Sep 16 20:32:59 volumio volumio[898]: error: error Sep 16 20:32:59 volumio volumio[898]: error: error Sep 16 20:32:59 volumio volumio[898]: error: error Sep 16 20:32:59 volumio volumio[898]: error: error Sep 16 20:33:00 volumio sudo[1309]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 16 20:33:00 volumio sudo[1309]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 20:33:00 volumio sudo[1309]: pam_unix(sudo:session): session closed for user root Sep 16 20:33:00 volumio sudo[1311]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 16 20:33:00 volumio sudo[1311]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 20:33:00 volumio sudo[1311]: pam_unix(sudo:session): session closed for user root Sep 16 20:33:00 volumio sudo[1315]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Sep 16 20:33:00 volumio sudo[1315]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 20:33:00 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Sep 16 20:33:00 volumio sudo[1315]: pam_unix(sudo:session): session closed for user root Sep 16 20:33:00 volumio volumio[898]: info: Upmpdcli Daemon Started Sep 16 20:33:00 volumio volumio[1317]: Generating RSA private key, 4096 bit long modulus (2 primes) Sep 16 20:33:02 volumio volumio[898]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Sep 16 20:33:04 volumio sudo[1337]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 16 20:33:04 volumio sudo[1337]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 20:33:04 volumio sudo[1339]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 16 20:33:04 volumio sudo[1339]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 20:33:04 volumio sudo[1339]: pam_unix(sudo:session): session closed for user root Sep 16 20:33:04 volumio sudo[1337]: pam_unix(sudo:session): session closed for user root Sep 16 20:33:04 volumio systemd[1]: systemd-fsckd.service: Succeeded. Sep 16 20:33:05 volumio sudo[1343]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 16 20:33:05 volumio sudo[1343]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 20:33:05 volumio sudo[1343]: pam_unix(sudo:session): session closed for user root Sep 16 20:33:05 volumio sudo[1345]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 16 20:33:05 volumio sudo[1345]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 20:33:05 volumio sudo[1345]: pam_unix(sudo:session): session closed for user root Sep 16 20:33:05 volumio volumio[898]: verbose: New Socket.io Connection to 192.168.28.151 from 192.168.28.139 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/140.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Sep 16 20:33:05 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 16 20:33:05 volumio volumio[898]: info: CoreCommandRouter::volumioGetVisibleSources Sep 16 20:33:05 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 16 20:33:05 volumio volumio[898]: info: CoreCommandRouter::volumioGetState Sep 16 20:33:05 volumio volumio[898]: info: CorePlayQueue::getTrack 0 Sep 16 20:33:05 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Sep 16 20:33:05 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 16 20:33:05 volumio volumio[898]: info: Received Get System Info Sep 16 20:33:05 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 16 20:33:05 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 16 20:33:05 volumio volumio[898]: info: Discovery: Getting this device information Sep 16 20:33:05 volumio volumio[898]: info: CoreCommandRouter::volumioGetState Sep 16 20:33:05 volumio volumio[898]: info: CorePlayQueue::getTrack 0 Sep 16 20:33:05 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 16 20:33:05 volumio volumio[898]: info: CoreCommandRouter::volumioGetState Sep 16 20:33:05 volumio volumio[898]: info: CorePlayQueue::getTrack 0 Sep 16 20:33:05 volumio volumio[898]: info: Listing playlists Sep 16 20:33:05 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Sep 16 20:33:05 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 16 20:33:06 volumio volumio[898]: info: CoreCommandRouter::volumioGetState Sep 16 20:33:06 volumio volumio[898]: info: CorePlayQueue::getTrack 0 Sep 16 20:33:06 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Sep 16 20:33:06 volumio volumio[898]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Sep 16 20:33:06 volumio volumio[898]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Sep 16 20:33:06 volumio volumio[898]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Sep 16 20:33:06 volumio volumio[898]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Sep 16 20:33:06 volumio volumio[898]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Sep 16 20:33:06 volumio volumio[898]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Sep 16 20:33:06 volumio volumio[898]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Sep 16 20:33:06 volumio volumio[898]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Sep 16 20:33:06 volumio volumio[898]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Sep 16 20:33:06 volumio volumio[898]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Sep 16 20:33:06 volumio volumio[898]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Sep 16 20:33:06 volumio volumio[898]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Sep 16 20:33:06 volumio volumio[898]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Sep 16 20:33:06 volumio volumio[898]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Sep 16 20:33:06 volumio volumio[898]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Sep 16 20:33:06 volumio volumio[898]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Sep 16 20:33:06 volumio volumio[898]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Sep 16 20:33:06 volumio volumio[898]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Sep 16 20:33:06 volumio volumio[898]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Sep 16 20:33:06 volumio volumio[898]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Sep 16 20:33:06 volumio volumio[898]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Sep 16 20:33:06 volumio volumio[898]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Sep 16 20:33:06 volumio volumio[898]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Sep 16 20:33:06 volumio volumio[898]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Sep 16 20:33:06 volumio volumio[898]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Sep 16 20:33:06 volumio volumio[898]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Sep 16 20:33:06 volumio volumio[898]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Sep 16 20:33:06 volumio volumio[898]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Sep 16 20:33:06 volumio volumio[898]: info: Adding plugin bluetooth to MyMusic Plugins Sep 16 20:33:06 volumio volumio[898]: info: Adding plugin multiroom to MyMusic Plugins Sep 16 20:33:06 volumio volumio[898]: info: Adding plugin metavolumio to MyMusic Plugins Sep 16 20:33:06 volumio volumio[898]: info: Adding plugin cd_controller to MyMusic Plugins Sep 16 20:33:06 volumio volumio[898]: info: Adding plugin qobuzconnect to MyMusic Plugins Sep 16 20:33:06 volumio volumio[898]: info: Adding plugin smart_inputs to MyMusic Plugins Sep 16 20:33:06 volumio volumio[898]: info: Adding plugin tidalconnect to MyMusic Plugins Sep 16 20:33:06 volumio volumio[898]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Sep 16 20:33:07 volumio volumio[1317]: ..................................................++++ Sep 16 20:33:08 volumio volumio[898]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Sep 16 20:33:08 volumio volumio[898]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Sep 16 20:33:08 volumio volumio[1317]: ...++++ Sep 16 20:33:08 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 20:33:08 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 20:33:08 volumio volumio[1317]: e is 65537 (0x010001) Sep 16 20:33:08 volumio volumio[898]: info: Starting MyVolumio Remote Streaming Endpoints Sep 16 20:33:08 volumio volumio[1317]: writing RSA key Sep 16 20:33:08 volumio volumio[898]: info: MyVolumio not started Sep 16 20:33:08 volumio volumio[898]: info: Initializing device activation check Sep 16 20:33:08 volumio volumio[898]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Sep 16 20:33:08 volumio volumio[898]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Sep 16 20:33:09 volumio systemd[1]: systemd-hostnamed.service: Succeeded. Sep 16 20:33:10 volumio volumio[898]: info: Starting Streaming Service Transparent Proxy Sep 16 20:33:10 volumio volumio[898]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Sep 16 20:33:10 volumio volumio[898]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Sep 16 20:33:10 volumio volumio[898]: info: Streaming services startup Sep 16 20:33:10 volumio volumio[898]: info: Starting Streaming Daemon Sep 16 20:33:10 volumio sudo[1407]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Sep 16 20:33:10 volumio sudo[1407]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 20:33:10 volumio volumio[898]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Sep 16 20:33:10 volumio sudo[1407]: pam_unix(sudo:session): session closed for user root Sep 16 20:33:10 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 16 20:33:10 volumio volumio[898]: info: Received Get System Info Sep 16 20:33:10 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 16 20:33:10 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 16 20:33:10 volumio volumio[898]: info: Discovery: Getting this device information Sep 16 20:33:10 volumio volumio[898]: info: CoreCommandRouter::volumioGetState Sep 16 20:33:10 volumio volumio[898]: info: CorePlayQueue::getTrack 0 Sep 16 20:33:10 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 16 20:33:10 volumio volumio[898]: error: Cannot start Volumio Streaming Daemon Sep 16 20:33:10 volumio volumio[898]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Sep 16 20:33:10 volumio volumio[898]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Sep 16 20:33:10 volumio volumio[898]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 16 20:33:10 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Sep 16 20:33:10 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Sep 16 20:33:10 volumio sudo[1417]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Sep 16 20:33:10 volumio sudo[1417]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 20:33:10 volumio sudo[1422]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Sep 16 20:33:10 volumio sudo[1422]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 20:33:10 volumio sudo[1417]: pam_unix(sudo:session): session closed for user root Sep 16 20:33:10 volumio sudo[1422]: pam_unix(sudo:session): session closed for user root Sep 16 20:33:11 volumio sudo[1429]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Sep 16 20:33:11 volumio sudo[1429]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 20:33:11 volumio sudo[1429]: pam_unix(sudo:session): session closed for user root Sep 16 20:33:11 volumio sudo[1435]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Sep 16 20:33:11 volumio sudo[1435]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 20:33:11 volumio sudo[1435]: pam_unix(sudo:session): session closed for user root Sep 16 20:33:11 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Sep 16 20:33:11 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Sep 16 20:33:11 volumio sudo[1442]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 16 20:33:11 volumio sudo[1442]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 20:33:11 volumio sudo[1442]: pam_unix(sudo:session): session closed for user root Sep 16 20:33:11 volumio sudo[1445]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 16 20:33:11 volumio sudo[1445]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 20:33:11 volumio sudo[1445]: pam_unix(sudo:session): session closed for user root Sep 16 20:33:11 volumio sudo[1448]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Sep 16 20:33:11 volumio sudo[1448]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 20:33:11 volumio volumio[898]: STREAMING PROXY: Starting server on port 3245 Sep 16 20:33:11 volumio volumio[898]: Node JS runtime: 14 Sep 16 20:33:11 volumio sudo[1448]: pam_unix(sudo:session): session closed for user root Sep 16 20:33:15 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 16 20:33:18 volumio systemd[1]: systemd-timedated.service: Succeeded. Sep 16 20:33:23 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 16 20:33:23 volumio volumio[898]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Sep 16 20:33:23 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Sep 16 20:33:23 volumio volumio[898]: info: Received Get System Version Sep 16 20:33:23 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 16 20:33:23 volumio volumio[898]: info: Received Get System Info Sep 16 20:33:23 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 16 20:33:23 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 16 20:33:23 volumio volumio[898]: info: Discovery: Getting this device information Sep 16 20:33:23 volumio volumio[898]: info: CoreCommandRouter::volumioGetState Sep 16 20:33:23 volumio volumio[898]: info: CorePlayQueue::getTrack 0 Sep 16 20:33:23 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 16 20:33:23 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 16 20:33:23 volumio volumio[898]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Sep 16 20:33:23 volumio volumio[898]: info: CoreCommandRouter::volumioGetState Sep 16 20:33:23 volumio volumio[898]: info: CorePlayQueue::getTrack 0 Sep 16 20:33:24 volumio volumio[898]: info: CoreCommandRouter::volumioGetState Sep 16 20:33:24 volumio volumio[898]: info: CorePlayQueue::getTrack 0 Sep 16 20:33:25 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 16 20:33:25 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 20:33:25 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 16 20:33:25 volumio volumio-remote-updater[607]: No test mode Sep 16 20:33:25 volumio volumio-remote-updater[607]: No alpha test mode Sep 16 20:33:25 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Sep 16 20:33:25 volumio volumio[898]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Sep 16 20:33:25 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Sep 16 20:33:26 volumio volumio[898]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 16 20:33:26 volumio volumio[898]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 16 20:33:26 volumio volumio[898]: info: Retrieving Cloud Streaming UI Sep 16 20:33:26 volumio volumio[898]: info: Getting Tidal Cloud Configuration Sep 16 20:33:26 volumio volumio[898]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 16 20:33:26 volumio volumio[898]: info: Getting Qobuz Cloud Configuration Sep 16 20:33:26 volumio volumio[898]: info: Asking plugin for UI Config Sep 16 20:33:26 volumio volumio[898]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 16 20:33:26 volumio volumio[898]: info: Getting Spotify Cloud Configuration Sep 16 20:33:26 volumio volumio[898]: info: Asking plugin for UI Config Sep 16 20:33:26 volumio volumio[898]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 16 20:33:26 volumio volumio[898]: info: Saving Spotify Acccount Sep 16 20:33:26 volumio volumio[898]: info: Got Tidal Cloud Configuration Sep 16 20:33:26 volumio volumio[898]: info: Got it Sep 16 20:33:26 volumio volumio[898]: info: Got it Sep 16 20:33:26 volumio volumio[898]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Sep 16 20:33:26 volumio volumio[898]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 16 20:33:26 volumio volumio[898]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Sep 16 20:33:26 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Sep 16 20:33:26 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Sep 16 20:33:26 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Sep 16 20:33:26 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Sep 16 20:33:26 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 16 20:33:26 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 16 20:33:26 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 16 20:33:26 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 16 20:33:26 volumio volumio[898]: info: CoreCommandRouter::volumioGetBrowseSources Sep 16 20:33:26 volumio volumio[898]: info: CoreCommandRouter::volumioGetBrowseSources Sep 16 20:33:26 volumio volumio[898]: info: CoreCommandRouter::volumioGetBrowseSources Sep 16 20:33:27 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 16 20:33:27 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Sep 16 20:33:28 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 20:33:28 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 20:33:28 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Sep 16 20:33:28 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Sep 16 20:33:28 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Sep 16 20:33:28 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Sep 16 20:33:28 volumio volumio[898]: info: CoreCommandRouter::volumioGetBrowseSources Sep 16 20:33:28 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 16 20:33:30 volumio volumio[898]: error: MyVolumio Plugin failed to authenticate in a timely fashion Sep 16 20:33:30 volumio volumio[898]: info: Completed starting MyVolumio Plugin Sep 16 20:33:30 volumio volumio[898]: [Metrics] CommandRouter: 44s 280.85ms Sep 16 20:33:30 volumio volumio[898]: info: CoreCommandRouter::volumiosetStartupVolume Sep 16 20:33:30 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 20:33:30 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 20:33:30 volumio volumio[898]: info: CoreCommandRouter::Close All Modals sent Sep 16 20:33:30 volumio volumio[898]: info: CoreCommandRouter::Close All Modals sent Sep 16 20:33:31 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 16 20:33:31 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Sep 16 20:33:31 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Sep 16 20:33:31 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Sep 16 20:33:31 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 16 20:33:31 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Sep 16 20:33:32 volumio volumio[898]: info: Executing SMB command: smbclient --no-pass --debuglevel=0 -L milantn1.local. -m SMB3_11 Sep 16 20:33:32 volumio volumio[898]: info: Executing SMB command: smbclient --no-pass --debuglevel=0 -L MiLanDS723Plus.local. -m SMB3_11 Sep 16 20:33:32 volumio volumio[898]: info: Executing SMB command: smbclient --no-pass --debuglevel=0 -L MILAN918P.local. -m SMB3_11 Sep 16 20:33:32 volumio volumio[898]: info: Executing SMB command: smbclient --no-pass --debuglevel=0 -L mlsrv.local. -m SMB3_11 Sep 16 20:33:32 volumio volumio[898]: info: Executing SMB command: smbclient --no-pass --debuglevel=0 -L B450iMate.local. -m SMB3_11 Sep 16 20:33:32 volumio volumio[898]: info: Executing SMB command: smbclient --no-pass --debuglevel=0 -L tnbackup.local. -m SMB3_11 Sep 16 20:33:32 volumio volumio[898]: info: Executing SMB command: smbclient --no-pass --debuglevel=0 -L fritz.box. -m SMB3_11 Sep 16 20:33:32 volumio volumio[898]: info: Executing SMB command: smbclient --no-pass --debuglevel=0 -L fritz.box. -m SMB3_11 Sep 16 20:33:33 volumio volumio[898]: info: Error browsing device MiLanDS723Plus for shares: Command failed: smbclient --no-pass --debuglevel=0 -L MiLanDS723Plus.local. -m SMB3_11 Sep 16 20:33:33 volumio volumio[898]: Unable to initialize messaging context Sep 16 20:33:33 volumio volumio[898]: info: Error browsing device MILAN918P for shares: Command failed: smbclient --no-pass --debuglevel=0 -L MILAN918P.local. -m SMB3_11 Sep 16 20:33:33 volumio volumio[898]: Unable to initialize messaging context Sep 16 20:33:33 volumio volumio[898]: info: Error browsing device tnbackup for shares: Command failed: smbclient --no-pass --debuglevel=0 -L tnbackup.local. -m SMB3_11 Sep 16 20:33:33 volumio volumio[898]: Unable to initialize messaging context Sep 16 20:33:35 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 16 20:33:36 volumio volumio[898]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 16 20:33:36 volumio volumio[898]: Error: dns service error: unknown Sep 16 20:33:36 volumio volumio[898]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30) Sep 16 20:33:36 volumio volumio[898]: at SocketWatcher.MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Sep 16 20:33:36 volumio volumio[898]: errorCode: -65537 Sep 16 20:33:36 volumio volumio[898]: } Sep 16 20:33:36 volumio volumio[898]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 16 20:33:36 volumio sudo[1571]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-16 20:32 Sep 16 20:33:36 volumio sudo[1571]: 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="29866754e5f1d7e4d0f581c10d9f22852f6f21db" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 10:25:36 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="cf6e14681b2ecbbdc9a62186b0f3114c"