-- Logs begin at Sun 2024-10-13 12:57:33 CST, end at Sun 2024-10-13 13:00:01 CST. -- Oct 13 12:59:00 volumio volumio[1229]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Oct 13 12:59:00 volumio ntpd[1330]: Soliciting pool server 193.182.111.12 Oct 13 12:59:00 volumio sudo[2393]: pam_unix(sudo:session): session closed for user root Oct 13 12:59:00 volumio volumio[1229]: info: Uninstall script completed Oct 13 12:59:00 volumio volumio[1229]: info: Removing plugin jellyfin_server from configuration Oct 13 12:59:01 volumio ntpd[1330]: Soliciting pool server 84.16.67.12 Oct 13 12:59:01 volumio volumio[1229]: info: Successfully removed jellyfin_server configuration files Oct 13 12:59:01 volumio volumio[1229]: info: Plugin folders cleanup Oct 13 12:59:01 volumio volumio[1229]: info: Scanning into folder /volumio/app/plugins/ Oct 13 12:59:01 volumio volumio[1229]: info: Scanning category audio_interface Oct 13 12:59:01 volumio volumio[1229]: info: Scanning category miscellanea Oct 13 12:59:01 volumio volumio[1229]: info: Scanning category music_service Oct 13 12:59:01 volumio volumio[1229]: info: Scanning category plugins.json Oct 13 12:59:01 volumio volumio[1229]: info: Scanning category system_controller Oct 13 12:59:01 volumio volumio[1229]: info: Scanning category user_interface Oct 13 12:59:01 volumio volumio[1229]: info: Scanning into folder /data/plugins/ Oct 13 12:59:01 volumio volumio[1229]: info: Scanning category music_service Oct 13 12:59:01 volumio volumio[1229]: info: Cleaning folder for jellyfin_server Oct 13 12:59:01 volumio volumio[1229]: info: Scanning category system_controller Oct 13 12:59:01 volumio volumio[1229]: info: Scanning category user_interface Oct 13 12:59:01 volumio volumio[1229]: info: Plugin folders cleanup completed Oct 13 12:59:01 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 13 12:59:01 volumio volumio[1229]: info: [{"prettyName":"Roon Bridge","name":"RoonBridge","category":"music_service","version":"1.0.0","icon":"fas fa-volume-up","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Jellyfin","name":"jellyfin","category":"music_service","version":"1.1.1","icon":"fa-music","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Logitech Media Server","name":"lms","category":"music_service","version":"1.2.6","icon":"fa fa-music","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"miniDLNA","name":"minidlna","category":"music_service","version":"3.1.12","icon":"fa-share-alt","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"AutoStart","name":"autostart","category":"system_controller","version":"3.0.4","icon":"fa-lightbulb-o","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"PeppyMeter Screensaver","name":"peppy_screensaver","category":"user_interface","version":"2.2.1","icon":"fa-lightbulb-o","isManuallyInstalled":true,"enabled":true,"active":true}] Oct 13 12:59:01 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 13 12:59:02 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 13 12:59:02 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 13 12:59:03 volumio volumio[1229]: info: CoreCommandRouter::volumioGetVisibleSources Oct 13 12:59:03 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 13 12:59:03 volumio volumio[1229]: info: CoreCommandRouter::volumioGetState Oct 13 12:59:03 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 13 12:59:03 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 13 12:59:03 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 13 12:59:03 volumio volumio[1229]: info: Received Get System Info Oct 13 12:59:03 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 13 12:59:03 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 13 12:59:03 volumio volumio[1229]: info: Discovery: Getting this device information Oct 13 12:59:03 volumio volumio[1229]: info: CoreCommandRouter::volumioGetState Oct 13 12:59:03 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 13 12:59:03 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 13 12:59:03 volumio volumio[1229]: info: CoreCommandRouter::volumioGetState Oct 13 12:59:03 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 13 12:59:03 volumio volumio[1229]: info: Listing playlists Oct 13 12:59:03 volumio volumio[1229]: info: CoreCommandRouter::volumioGetState Oct 13 12:59:03 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 13 12:59:03 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 13 12:59:03 volumio volumio[1229]: info: Received Get System Info Oct 13 12:59:03 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 13 12:59:03 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 13 12:59:03 volumio volumio[1229]: info: Discovery: Getting this device information Oct 13 12:59:03 volumio volumio[1229]: info: CoreCommandRouter::volumioGetState Oct 13 12:59:03 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 13 12:59:03 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 13 12:59:03 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 12:59:03 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 12:59:03 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Oct 13 12:59:03 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Oct 13 12:59:03 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Oct 13 12:59:03 volumio volumio[1229]: info: CoreCommandRouter::volumioGetBrowseSources Oct 13 12:59:03 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 13 12:59:04 volumio RoonBridge[1835]: 00:00:46.114 Warn: exception starting raatserver: System.Net.Sockets.SocketException (0x80004005): Connection refused Oct 13 12:59:04 volumio RoonBridge[1835]: at System.Net.Sockets.TcpClient..ctor (System.String hostname, System.Int32 port) [0x0006d] in <08911f3881ec4a92acc8fdc4d13b73bf>:0 Oct 13 12:59:04 volumio RoonBridge[1835]: at Sooloos.RAATServer.ConnectOrStartAndWaitForExit (System.String path, System.String args, System.Action`1[T] status, Base.ChildProcess& p) [0x00165] in <5529660cb9214b5a92e49e1607b30d50>:0 Oct 13 12:59:04 volumio RoonBridge[1835]: Not Running (.o) Oct 13 12:59:04 volumio RoonBridge[1835]: 00:00:46.118 Debug: PathForResource, filename: ../.update Oct 13 12:59:04 volumio RoonBridge[1835]: 00:00:46.119 Debug: PathForResource, candidate: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/../.update Oct 13 12:59:05 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 13 12:59:05 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 13 12:59:05 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 13 12:59:05 volumio volumio[1229]: info: Starting Uninstall of plugin music_service - minidlna Oct 13 12:59:05 volumio volumio[1229]: info: Uninstalling plugin minidlna Oct 13 12:59:05 volumio volumio[1229]: info: minidlna: Stopping minidlna.service Oct 13 12:59:06 volumio sudo[2424]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop minidlna.service Oct 13 12:59:06 volumio sudo[2424]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 13 12:59:06 volumio systemd[1]: Stopping MiniDLNA lightweight DLNA/UPnP-AV server... Oct 13 12:59:06 volumio systemd[1]: minidlna.service: Succeeded. Oct 13 12:59:06 volumio systemd[1]: Stopped MiniDLNA lightweight DLNA/UPnP-AV server. Oct 13 12:59:06 volumio sudo[2424]: pam_unix(sudo:session): session closed for user root Oct 13 12:59:06 volumio volumio[1229]: info: minidlna: systemctl stop minidlna.service succeeded. Oct 13 12:59:06 volumio volumio[1229]: info: Disabling plugin minidlna Oct 13 12:59:06 volumio volumio[1229]: info: Checking if uninstall.sh is present Oct 13 12:59:06 volumio volumio[1229]: info: Executing uninstall.sh Oct 13 12:59:06 volumio sudo[2432]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/music_service/minidlna/uninstall.sh Oct 13 12:59:06 volumio sudo[2432]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 13 12:59:06 volumio RoonBridge[1835]: 00:00:48.119 Info: ConnectOrStartAndWaitForExit RAATServer, path: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RAATServer Oct 13 12:59:06 volumio RoonBridge[1835]: Running Oct 13 12:59:06 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Oct 13 12:59:07 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 13 12:59:07 volumio volumio[1229]: info: Received Get System Info Oct 13 12:59:07 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 13 12:59:07 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 13 12:59:07 volumio volumio[1229]: info: Discovery: Getting this device information Oct 13 12:59:07 volumio volumio[1229]: info: CoreCommandRouter::volumioGetState Oct 13 12:59:07 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 13 12:59:07 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 13 12:59:08 volumio volumio[1229]: info: Setting Geolocation for MyVolumio to us2 Oct 13 12:59:08 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 13 12:59:08 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 13 12:59:08 volumio volumio[1229]: error: MyVolumio Plugin failed to authenticate in a timely fashion Oct 13 12:59:08 volumio volumio[1229]: info: Completed starting MyVolumio Plugin Oct 13 12:59:08 volumio volumio[1229]: info: BOOT COMPLETED Oct 13 12:59:08 volumio volumio[1229]: [Metrics] CommandRouter: 73s 923.38ms Oct 13 12:59:08 volumio volumio[1229]: info: CoreCommandRouter::volumiosetStartupVolume Oct 13 12:59:08 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 12:59:08 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 13 12:59:08 volumio volumio[1229]: info: CoreCommandRouter::Close All Modals sent Oct 13 12:59:08 volumio volumio[1229]: info: CoreCommandRouter::Close All Modals sent Oct 13 12:59:08 volumio volumio[1229]: info: Cannot play startup sound: Error: Command failed: /usr/bin/aplay -D volumio /volumio/app/startup.wav Oct 13 12:59:08 volumio volumio[1229]: ALSA lib pcm_hw.c:1822:(_snd_pcm_hw_open) Invalid value for card Oct 13 12:59:08 volumio volumio[1229]: aplay: main:828: audio open error: No such device Oct 13 12:59:09 volumio volumio[1229]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Oct 13 12:59:09 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 13 12:59:09 volumio volumio[1229]: info: Received Get System Info Oct 13 12:59:09 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 13 12:59:09 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 13 12:59:09 volumio volumio[1229]: info: Discovery: Getting this device information Oct 13 12:59:09 volumio volumio[1229]: info: CoreCommandRouter::volumioGetState Oct 13 12:59:09 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 13 12:59:09 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 13 12:59:09 volumio volumio[1229]: info: Updating MyVolumio device info Oct 13 12:59:09 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 13 12:59:09 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 13 12:59:09 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 13 12:59:09 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Oct 13 12:59:09 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 13 12:59:10 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Oct 13 12:59:10 volumio volumio[1229]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Oct 13 12:59:10 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 13 12:59:12 volumio volumio[1229]: info: Starting Uninstall of plugin music_service - lms Oct 13 12:59:12 volumio volumio[1229]: info: Uninstalling plugin lms Oct 13 12:59:12 volumio sudo[2476]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop logitechmediaserver Oct 13 12:59:12 volumio sudo[2476]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 13 12:59:12 volumio sudo[2476]: pam_unix(sudo:session): session closed for user root Oct 13 12:59:12 volumio volumio[1229]: info: logitechmediaserver stopped Oct 13 12:59:12 volumio volumio[1229]: info: Disabling plugin lms Oct 13 12:59:12 volumio volumio[1229]: info: Checking if uninstall.sh is present Oct 13 12:59:12 volumio volumio[1229]: info: Executing uninstall.sh Oct 13 12:59:12 volumio RoonBridge[1835]: 00:00:54.159 Warn: exception starting raatserver: System.Net.Sockets.SocketException (0x80004005): Connection refused Oct 13 12:59:12 volumio RoonBridge[1835]: at System.Net.Sockets.TcpClient..ctor (System.String hostname, System.Int32 port) [0x0006d] in <08911f3881ec4a92acc8fdc4d13b73bf>:0 Oct 13 12:59:12 volumio RoonBridge[1835]: at Sooloos.RAATServer.ConnectOrStartAndWaitForExit (System.String path, System.String args, System.Action`1[T] status, Base.ChildProcess& p) [0x00165] in <5529660cb9214b5a92e49e1607b30d50>:0 Oct 13 12:59:12 volumio RoonBridge[1835]: Not Running (.o) Oct 13 12:59:12 volumio RoonBridge[1835]: 00:00:54.173 Debug: PathForResource, filename: ../.update Oct 13 12:59:12 volumio RoonBridge[1835]: 00:00:54.173 Debug: PathForResource, candidate: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/../.update Oct 13 12:59:12 volumio sudo[2490]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/music_service/lms/uninstall.sh Oct 13 12:59:12 volumio sudo[2490]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 13 12:59:13 volumio volumio[1229]: info: MYVOLUMIO: Adding device Oct 13 12:59:13 volumio volumio[1229]: info: MYVOLUMIO: Evaluating Server Oct 13 12:59:13 volumio sudo[2490]: pam_unix(sudo:session): session closed for user root Oct 13 12:59:13 volumio volumio[1229]: info: Uninstall script completed Oct 13 12:59:13 volumio volumio[1229]: info: Removing plugin lms from configuration Oct 13 12:59:13 volumio volumio[1229]: info: Successfully removed lms configuration files Oct 13 12:59:13 volumio volumio[1229]: info: Plugin folders cleanup Oct 13 12:59:13 volumio volumio[1229]: info: Scanning into folder /volumio/app/plugins/ Oct 13 12:59:13 volumio volumio[1229]: info: Scanning category audio_interface Oct 13 12:59:13 volumio volumio[1229]: info: Scanning category miscellanea Oct 13 12:59:13 volumio volumio[1229]: info: Scanning category music_service Oct 13 12:59:13 volumio volumio[1229]: info: Scanning category plugins.json Oct 13 12:59:13 volumio volumio[1229]: info: Scanning category system_controller Oct 13 12:59:13 volumio volumio[1229]: info: Scanning category user_interface Oct 13 12:59:13 volumio volumio[1229]: info: Scanning into folder /data/plugins/ Oct 13 12:59:13 volumio volumio[1229]: info: Scanning category music_service Oct 13 12:59:13 volumio volumio[1229]: info: Cleaning folder for lms Oct 13 12:59:14 volumio volumio[1229]: info: Scanning category system_controller Oct 13 12:59:14 volumio volumio[1229]: info: Scanning category user_interface Oct 13 12:59:14 volumio volumio[1229]: info: Plugin folders cleanup completed Oct 13 12:59:14 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 13 12:59:14 volumio volumio[1229]: info: [{"prettyName":"Roon Bridge","name":"RoonBridge","category":"music_service","version":"1.0.0","icon":"fas fa-volume-up","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Jellyfin","name":"jellyfin","category":"music_service","version":"1.1.1","icon":"fa-music","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"miniDLNA","name":"minidlna","category":"music_service","version":"3.1.12","icon":"fa-share-alt","isManuallyInstalled":false,"enabled":false,"active":false},{"prettyName":"AutoStart","name":"autostart","category":"system_controller","version":"3.0.4","icon":"fa-lightbulb-o","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"PeppyMeter Screensaver","name":"peppy_screensaver","category":"user_interface","version":"2.2.1","icon":"fa-lightbulb-o","isManuallyInstalled":true,"enabled":true,"active":true}] Oct 13 12:59:14 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 13 12:59:14 volumio RoonBridge[1835]: 00:00:56.173 Info: ConnectOrStartAndWaitForExit RAATServer, path: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RAATServer Oct 13 12:59:14 volumio RoonBridge[1835]: Running Oct 13 12:59:15 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 13 12:59:15 volumio volumio[1229]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Oct 13 12:59:15 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Oct 13 12:59:15 volumio volumio[1229]: info: Received Get System Version Oct 13 12:59:15 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 13 12:59:15 volumio volumio[1229]: info: Received Get System Info Oct 13 12:59:15 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 13 12:59:15 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 13 12:59:15 volumio volumio[1229]: info: Discovery: Getting this device information Oct 13 12:59:15 volumio volumio[1229]: info: CoreCommandRouter::volumioGetState Oct 13 12:59:15 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 13 12:59:15 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 13 12:59:15 volumio volumio[1229]: info: Setting Geolocation for MyVolumio to us2 Oct 13 12:59:15 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 13 12:59:16 volumio volumio[1229]: info: Updating MyVolumio device info Oct 13 12:59:16 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 13 12:59:16 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 13 12:59:17 volumio volumio[1229]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Oct 13 12:59:17 volumio volumio[1229]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Oct 13 12:59:21 volumio systemd[1]: Reloading. Oct 13 12:59:21 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Oct 13 12:59:22 volumio systemd[1]: getty@tty1.service: Current command vanished from the unit file, execution of the command list won't be resumed. Oct 13 12:59:22 volumio systemd[1]: Configuration file /etc/systemd/system/jellyfin.service is marked world-inaccessible. This has no effect as configuration data is accessible via APIs without restrictions. Proceeding anyway. Oct 13 12:59:22 volumio systemd[1]: Reloading. Oct 13 12:59:22 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 13 12:59:22 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 13 12:59:22 volumio volumio[1229]: info: Discovery: Getting this device information Oct 13 12:59:22 volumio volumio[1229]: info: CoreCommandRouter::volumioGetState Oct 13 12:59:22 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 13 12:59:22 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 13 12:59:23 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Oct 13 12:59:23 volumio volumio[1229]: info: Starting Uninstall of plugin music_service - minidlna Oct 13 12:59:23 volumio volumio[1229]: info: Uninstalling plugin minidlna Oct 13 12:59:23 volumio volumio[1229]: info: minidlna: Stopping minidlna.service Oct 13 12:59:23 volumio sudo[2659]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop minidlna.service Oct 13 12:59:23 volumio sudo[2659]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 13 12:59:23 volumio systemd[1]: Configuration file /etc/systemd/system/jellyfin.service is marked world-inaccessible. This has no effect as configuration data is accessible via APIs without restrictions. Proceeding anyway. Oct 13 12:59:23 volumio sudo[2659]: pam_unix(sudo:session): session closed for user root Oct 13 12:59:24 volumio volumio[1229]: info: minidlna: systemctl stop minidlna.service succeeded. Oct 13 12:59:24 volumio volumio[1229]: info: Disabling plugin minidlna Oct 13 12:59:24 volumio volumio[1229]: info: Checking if uninstall.sh is present Oct 13 12:59:24 volumio volumio[1229]: info: Executing uninstall.sh Oct 13 12:59:24 volumio sudo[2671]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/music_service/minidlna/uninstall.sh Oct 13 12:59:24 volumio sudo[2671]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 13 12:59:24 volumio systemd[1]: Reloading. Oct 13 12:59:25 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Oct 13 12:59:25 volumio systemd[1]: Configuration file /etc/systemd/system/jellyfin.service is marked world-inaccessible. This has no effect as configuration data is accessible via APIs without restrictions. Proceeding anyway. Oct 13 12:59:26 volumio sudo[2671]: pam_unix(sudo:session): session closed for user root Oct 13 12:59:26 volumio volumio[1229]: info: Uninstall script completed Oct 13 12:59:26 volumio volumio[1229]: info: Removing plugin minidlna from configuration Oct 13 12:59:27 volumio volumio[1229]: info: Successfully removed minidlna configuration files Oct 13 12:59:27 volumio volumio[1229]: info: Plugin folders cleanup Oct 13 12:59:27 volumio volumio[1229]: info: Scanning into folder /volumio/app/plugins/ Oct 13 12:59:27 volumio volumio[1229]: info: Scanning category audio_interface Oct 13 12:59:27 volumio volumio[1229]: info: Scanning category miscellanea Oct 13 12:59:27 volumio volumio[1229]: info: Scanning category music_service Oct 13 12:59:27 volumio volumio[1229]: info: Scanning category plugins.json Oct 13 12:59:27 volumio volumio[1229]: info: Scanning category system_controller Oct 13 12:59:27 volumio volumio[1229]: info: Scanning category user_interface Oct 13 12:59:27 volumio volumio[1229]: info: Scanning into folder /data/plugins/ Oct 13 12:59:27 volumio volumio[1229]: info: Scanning category music_service Oct 13 12:59:27 volumio volumio[1229]: info: Cleaning folder for minidlna Oct 13 12:59:27 volumio volumio[1229]: info: Scanning category system_controller Oct 13 12:59:27 volumio volumio[1229]: info: Scanning category user_interface Oct 13 12:59:27 volumio volumio[1229]: info: Plugin folders cleanup completed Oct 13 12:59:27 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 13 12:59:27 volumio volumio[1229]: info: [{"prettyName":"Roon Bridge","name":"RoonBridge","category":"music_service","version":"1.0.0","icon":"fas fa-volume-up","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Jellyfin","name":"jellyfin","category":"music_service","version":"1.1.1","icon":"fa-music","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"AutoStart","name":"autostart","category":"system_controller","version":"3.0.4","icon":"fa-lightbulb-o","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"PeppyMeter Screensaver","name":"peppy_screensaver","category":"user_interface","version":"2.2.1","icon":"fa-lightbulb-o","isManuallyInstalled":true,"enabled":true,"active":true}] Oct 13 12:59:27 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 13 12:59:29 volumio systemd[1]: Reloading. Oct 13 12:59:30 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Oct 13 12:59:30 volumio systemd[1]: Configuration file /etc/systemd/system/jellyfin.service is marked world-inaccessible. This has no effect as configuration data is accessible via APIs without restrictions. Proceeding anyway. Oct 13 12:59:30 volumio systemd[1]: Reloading. Oct 13 12:59:31 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Oct 13 12:59:31 volumio systemd[1]: Configuration file /etc/systemd/system/jellyfin.service is marked world-inaccessible. This has no effect as configuration data is accessible via APIs without restrictions. Proceeding anyway. Oct 13 12:59:33 volumio systemd[1]: Reloading. Oct 13 12:59:33 volumio volumio[1229]: info: Starting Uninstall of plugin system_controller - autostart Oct 13 12:59:33 volumio volumio[1229]: info: Uninstalling plugin autostart Oct 13 12:59:33 volumio volumio[1229]: info: AutoStart - onStop Oct 13 12:59:33 volumio volumio[1229]: info: Disabling plugin autostart Oct 13 12:59:33 volumio volumio[1229]: info: Checking if uninstall.sh is present Oct 13 12:59:33 volumio volumio[1229]: info: Executing uninstall.sh Oct 13 12:59:33 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Oct 13 12:59:33 volumio sudo[2788]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/system_controller/autostart/uninstall.sh Oct 13 12:59:33 volumio sudo[2788]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 13 12:59:33 volumio sudo[2788]: pam_unix(sudo:session): session closed for user root Oct 13 12:59:33 volumio volumio[1229]: info: Uninstall script completed Oct 13 12:59:33 volumio volumio[1229]: info: Removing plugin autostart from configuration Oct 13 12:59:34 volumio systemd[1]: Configuration file /etc/systemd/system/jellyfin.service is marked world-inaccessible. This has no effect as configuration data is accessible via APIs without restrictions. Proceeding anyway. Oct 13 12:59:34 volumio volumio[1229]: info: Successfully removed autostart configuration files Oct 13 12:59:34 volumio volumio[1229]: info: Plugin folders cleanup Oct 13 12:59:34 volumio volumio[1229]: info: Scanning into folder /volumio/app/plugins/ Oct 13 12:59:34 volumio volumio[1229]: info: Scanning category audio_interface Oct 13 12:59:34 volumio volumio[1229]: info: Scanning category miscellanea Oct 13 12:59:34 volumio volumio[1229]: info: Scanning category music_service Oct 13 12:59:34 volumio volumio[1229]: info: Scanning category plugins.json Oct 13 12:59:34 volumio volumio[1229]: info: Scanning category system_controller Oct 13 12:59:34 volumio volumio[1229]: info: Scanning category user_interface Oct 13 12:59:34 volumio volumio[1229]: info: Scanning into folder /data/plugins/ Oct 13 12:59:34 volumio volumio[1229]: info: Scanning category music_service Oct 13 12:59:34 volumio volumio[1229]: info: Scanning category system_controller Oct 13 12:59:34 volumio volumio[1229]: info: Cleaning folder for autostart Oct 13 12:59:34 volumio volumio[1229]: info: Scanning category user_interface Oct 13 12:59:34 volumio volumio[1229]: info: Plugin folders cleanup completed Oct 13 12:59:35 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 13 12:59:35 volumio volumio[1229]: info: [{"prettyName":"Roon Bridge","name":"RoonBridge","category":"music_service","version":"1.0.0","icon":"fas fa-volume-up","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Jellyfin","name":"jellyfin","category":"music_service","version":"1.1.1","icon":"fa-music","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"PeppyMeter Screensaver","name":"peppy_screensaver","category":"user_interface","version":"2.2.1","icon":"fa-lightbulb-o","isManuallyInstalled":true,"enabled":true,"active":true}] Oct 13 12:59:35 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 13 12:59:36 volumio systemd[1]: Reloading. Oct 13 12:59:36 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Oct 13 12:59:36 volumio systemd[1]: Configuration file /etc/systemd/system/jellyfin.service is marked world-inaccessible. This has no effect as configuration data is accessible via APIs without restrictions. Proceeding anyway. Oct 13 12:59:37 volumio sudo[2432]: pam_unix(sudo:session): session closed for user root Oct 13 12:59:37 volumio volumio[1229]: info: Uninstall script completed Oct 13 12:59:37 volumio volumio[1229]: info: Removing plugin minidlna from configuration Oct 13 12:59:51 volumio volumio[1229]: info: Successfully removed minidlna configuration files Oct 13 12:59:51 volumio volumio[1229]: info: Plugin folders cleanup Oct 13 12:59:51 volumio volumio[1229]: info: Scanning into folder /volumio/app/plugins/ Oct 13 12:59:51 volumio volumio[1229]: info: Scanning category audio_interface Oct 13 12:59:51 volumio volumio[1229]: info: Scanning category miscellanea Oct 13 12:59:51 volumio volumio[1229]: info: Scanning category music_service Oct 13 12:59:51 volumio volumio[1229]: info: Scanning category plugins.json Oct 13 12:59:51 volumio volumio[1229]: info: Scanning category system_controller Oct 13 12:59:51 volumio volumio[1229]: info: Scanning category user_interface Oct 13 12:59:51 volumio volumio[1229]: info: Scanning into folder /data/plugins/ Oct 13 12:59:51 volumio volumio[1229]: info: Scanning category music_service Oct 13 12:59:51 volumio volumio[1229]: info: Scanning category system_controller Oct 13 12:59:51 volumio volumio[1229]: info: Scanning category user_interface Oct 13 12:59:51 volumio volumio[1229]: info: Plugin folders cleanup completed Oct 13 12:59:51 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 13 12:59:51 volumio volumio[1229]: info: [{"prettyName":"Roon Bridge","name":"RoonBridge","category":"music_service","version":"1.0.0","icon":"fas fa-volume-up","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Jellyfin","name":"jellyfin","category":"music_service","version":"1.1.1","icon":"fa-music","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"PeppyMeter Screensaver","name":"peppy_screensaver","category":"user_interface","version":"2.2.1","icon":"fa-lightbulb-o","isManuallyInstalled":true,"enabled":true,"active":true}] Oct 13 12:59:51 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 13 12:59:51 volumio volumio[1229]: Upnp client error: Error: This socket has been ended by the other party Oct 13 12:59:51 volumio volumio[1229]: verbose: New Socket.io Connection to 192.168.31.204:3000 from 192.168.31.109 UA: Dart/3.4 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Oct 13 12:59:51 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 13 12:59:51 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 13 12:59:51 volumio volumio[1229]: info: Discovery: Getting this device information Oct 13 12:59:51 volumio volumio[1229]: info: CoreCommandRouter::volumioGetState Oct 13 12:59:51 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 13 12:59:51 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 13 12:59:51 volumio volumio[1229]: Upnp client error: Error: This socket has been ended by the other party Oct 13 12:59:51 volumio volumio[1229]: Upnp client error: Error: This socket has been ended by the other party Oct 13 12:59:51 volumio volumio[1229]: Upnp client error: Error: This socket has been ended by the other party Oct 13 12:59:52 volumio sudo[2845]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 13 12:59:52 volumio sudo[2845]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 13 12:59:52 volumio sudo[2845]: pam_unix(sudo:session): session closed for user root Oct 13 12:59:52 volumio sudo[2848]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 13 12:59:52 volumio sudo[2848]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 13 12:59:52 volumio sudo[2848]: pam_unix(sudo:session): session closed for user root Oct 13 12:59:52 volumio volumio[1229]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 7 Oct 13 12:59:52 volumio volumio[1229]: info: CoreCommandRouter::volumioGetState Oct 13 12:59:52 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 13 12:59:52 volumio volumio[1229]: verbose: New Socket.io Connection to 192.168.31.204 from 192.168.31.109 UA: Mozilla/5.0 (Linux; Android 14; 22122RK93C Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/129.0.6668.81 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Oct 13 12:59:52 volumio volumio[1229]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 9 Oct 13 12:59:52 volumio volumio[1229]: info: CoreCommandRouter::volumioGetState Oct 13 12:59:52 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 13 12:59:53 volumio volumio[1229]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Oct 13 12:59:53 volumio sudo[2867]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 13 12:59:53 volumio sudo[2867]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 13 12:59:53 volumio sudo[2867]: pam_unix(sudo:session): session closed for user root Oct 13 12:59:53 volumio sudo[2870]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 13 12:59:53 volumio sudo[2870]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 13 12:59:53 volumio sudo[2870]: pam_unix(sudo:session): session closed for user root Oct 13 12:59:53 volumio volumio[1229]: verbose: New Socket.io Connection to 192.168.31.204 from 192.168.31.109 UA: Mozilla/5.0 (Linux; Android 14; 22122RK93C Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/129.0.6668.81 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Oct 13 12:59:53 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 13 12:59:53 volumio volumio[1229]: info: CoreCommandRouter::volumioGetVisibleSources Oct 13 12:59:53 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 13 12:59:53 volumio volumio[1229]: info: CoreCommandRouter::volumioGetState Oct 13 12:59:53 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 13 12:59:53 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 13 12:59:53 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 13 12:59:53 volumio volumio[1229]: info: Received Get System Info Oct 13 12:59:53 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 13 12:59:53 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 13 12:59:53 volumio volumio[1229]: info: Discovery: Getting this device information Oct 13 12:59:53 volumio volumio[1229]: info: CoreCommandRouter::volumioGetState Oct 13 12:59:53 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 13 12:59:53 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 13 12:59:53 volumio volumio[1229]: info: CoreCommandRouter::volumioGetState Oct 13 12:59:53 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 13 12:59:53 volumio volumio[1229]: info: Listing playlists Oct 13 12:59:53 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 13 12:59:53 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 13 12:59:53 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 13 12:59:55 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 13 12:59:55 volumio volumio[1229]: info: Received Get System Info Oct 13 12:59:55 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 13 12:59:55 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 13 12:59:55 volumio volumio[1229]: info: Discovery: Getting this device information Oct 13 12:59:55 volumio volumio[1229]: info: CoreCommandRouter::volumioGetState Oct 13 12:59:55 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 13 12:59:55 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 13 12:59:55 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 13 12:59:55 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Oct 13 12:59:57 volumio volumio[1229]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 13 12:59:57 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 13 12:59:57 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 13 12:59:57 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 13 12:59:57 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 13 12:59:57 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 13 12:59:57 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 13 12:59:57 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 13 12:59:57 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 13 12:59:57 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 13 12:59:57 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 13 12:59:57 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Oct 13 12:59:57 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 13 12:59:59 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 13 12:59:59 volumio volumio[1229]: info: Received Get System Info Oct 13 12:59:59 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 13 12:59:59 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 13 12:59:59 volumio volumio[1229]: info: Discovery: Getting this device information Oct 13 12:59:59 volumio volumio[1229]: info: CoreCommandRouter::volumioGetState Oct 13 12:59:59 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 13 12:59:59 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 13 12:59:59 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 13 12:59:59 volumio volumio[1229]: info: Received Get System Info Oct 13 12:59:59 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 13 12:59:59 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 13 12:59:59 volumio volumio[1229]: info: Discovery: Getting this device information Oct 13 12:59:59 volumio volumio[1229]: info: CoreCommandRouter::volumioGetState Oct 13 12:59:59 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 13 12:59:59 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 13 13:00:00 volumio volumio[1229]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Oct 13 13:00:00 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Oct 13 13:00:00 volumio volumio[1229]: info: Preparing to save Alsa Options, stopping services first Oct 13 13:00:00 volumio volumio[1229]: info: CoreCommandRouter::volumioGetState Oct 13 13:00:00 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 13 13:00:00 volumio volumio[1229]: info: CoreCommandRouter::volumioPause Oct 13 13:00:00 volumio volumio[1229]: info: CoreStateMachine::pause Oct 13 13:00:00 volumio volumio[1229]: info: CoreStateMachine::stPlaybackTimer Oct 13 13:00:00 volumio volumio[1229]: info: CoreStateMachine::servicePause Oct 13 13:00:00 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 13 13:00:00 volumio volumio[1229]: info: CoreCommandRouter::servicePause Oct 13 13:00:00 volumio volumio[1229]: info: ControllerMpd::pause Oct 13 13:00:00 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand pause Oct 13 13:00:00 volumio volumio[1229]: info: Saving Audio Output to: {"output_device":{"value":"0,3","label":"HDMI"}} Oct 13 13:00:00 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 13 13:00:00 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 13 13:00:00 volumio volumio[1229]: info: Found match in Cards Database: setting mixer for card HDMI Oct 13 13:00:00 volumio volumio[1229]: info: Setting mixer IEC958 for card HDMI Oct 13 13:00:00 volumio volumio[1229]: info: CoreCommandRouter::volumioUpdateVolumeSettings Oct 13 13:00:00 volumio volumio[1229]: info: Updating Volume Controller Parameters: Device: 0,3 Name: HDMI Mixer: IEC958 Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Oct 13 13:00:00 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Oct 13 13:00:00 volumio volumio[1229]: info: Disabling external Volume Control Oct 13 13:00:00 volumio volumio[1229]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 13 13:00:00 volumio volumio[1229]: info: Preparing to generate the ALSA configuration file Oct 13 13:00:00 volumio volumio[1229]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Oct 13 13:00:00 volumio volumio[1229]: info: Reading ALSA contributions from plugins. Oct 13 13:00:00 volumio volumio[1229]: info: Oct 13 13:00:00 volumio volumio[1229]: ---------------------------- MPD announces state update: player Oct 13 13:00:00 volumio volumio[1229]: info: sendMpdCommand pause took 379 milliseconds Oct 13 13:00:00 volumio volumio[1229]: info: ControllerMpd::getState Oct 13 13:00:00 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand status Oct 13 13:00:00 volumio volumio[1229]: info: Oct 13 13:00:00 volumio volumio[1229]: ---------------------------- MPD announces state update: player Oct 13 13:00:00 volumio volumio[1229]: info: ControllerMpd::getState Oct 13 13:00:00 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand status Oct 13 13:00:00 volumio volumio[1229]: Unable to parse: Oct 13 13:00:00 volumio volumio[1229]: Simple mixer control 'IEC958',0 Oct 13 13:00:00 volumio volumio[1229]: Capabilities: pswitch pswitch-joined Oct 13 13:00:00 volumio volumio[1229]: Playback channels: Mono Oct 13 13:00:00 volumio volumio[1229]: Mono: Playback [off] Oct 13 13:00:00 volumio volumio[1229]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Oct 13 13:00:00 volumio volumio[1229]: info: sendMpdCommand status took 48 milliseconds Oct 13 13:00:00 volumio volumio[1229]: info: sendMpdCommand status took 46 milliseconds Oct 13 13:00:00 volumio volumio[1229]: verbose: ControllerMpd::parseState Oct 13 13:00:00 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 13 13:00:00 volumio volumio[1229]: verbose: ControllerMpd::parseState Oct 13 13:00:00 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 13 13:00:00 volumio volumio[1229]: info: sendMpdCommand playlistinfo took 18 milliseconds Oct 13 13:00:00 volumio volumio[1229]: info: sendMpdCommand playlistinfo took 17 milliseconds Oct 13 13:00:00 volumio volumio[1229]: verbose: ControllerMpd::parseTrackInfo Oct 13 13:00:00 volumio volumio[1229]: verbose: ControllerMpd::parseTrackInfo Oct 13 13:00:00 volumio volumio[1229]: info: ControllerMpd::pushState Oct 13 13:00:00 volumio volumio[1229]: info: CoreCommandRouter::servicePushState Oct 13 13:00:00 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 13 13:00:00 volumio volumio[1229]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":86808,"duration":337,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"954 Kbps","isStreaming":false,"title":"乌兰巴托的夜晚","artist":"赵鹏","album":"中国最好声音:人声测试专用大碟","uri":"USB/赵鹏 - 乌兰巴托的夜晚.flac","trackType":"flac"} Oct 13 13:00:00 volumio volumio[1229]: verbose: CURRENT POSITION 0 Oct 13 13:00:00 volumio volumio[1229]: info: CoreStateMachine::syncState stateService pause Oct 13 13:00:00 volumio volumio[1229]: info: CoreStateMachine::syncState currentStatus pause Oct 13 13:00:00 volumio volumio[1229]: info: CoreStateMachine::pushState Oct 13 13:00:00 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 13 13:00:00 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 13 13:00:00 volumio volumio[1229]: info: CoreCommandRouter::volumioPushState Oct 13 13:00:00 volumio volumio[1229]: info: CoreStateMachine::stPlaybackTimer Oct 13 13:00:00 volumio volumio[1229]: info: ControllerMpd::pushState Oct 13 13:00:00 volumio volumio[1229]: info: CoreCommandRouter::servicePushState Oct 13 13:00:00 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 13 13:00:00 volumio volumio[1229]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":86808,"duration":337,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"954 Kbps","isStreaming":false,"title":"乌兰巴托的夜晚","artist":"赵鹏","album":"中国最好声音:人声测试专用大碟","uri":"USB/赵鹏 - 乌兰巴托的夜晚.flac","trackType":"flac"} Oct 13 13:00:00 volumio volumio[1229]: verbose: CURRENT POSITION 0 Oct 13 13:00:00 volumio volumio[1229]: info: CoreStateMachine::syncState stateService pause Oct 13 13:00:00 volumio volumio[1229]: info: CoreStateMachine::syncState currentStatus pause Oct 13 13:00:00 volumio volumio[1229]: info: CoreStateMachine::pushState Oct 13 13:00:00 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 13 13:00:00 volumio volumio[1229]: info: CoreCommandRouter::volumioPushState Oct 13 13:00:00 volumio volumio[1229]: info: CoreStateMachine::stPlaybackTimer Oct 13 13:00:00 volumio volumio[1229]: info: ------------------------------ 162ms Oct 13 13:00:00 volumio volumio[1229]: info: ------------------------------ 159ms Oct 13 13:00:00 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 13 13:00:00 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 13 13:00:00 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 13 13:00:00 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 13 13:00:00 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 13 13:00:00 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 13 13:00:00 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 13 13:00:00 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 13 13:00:00 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 13 13:00:00 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Oct 13 13:00:00 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 13 13:00:00 volumio volumio[1229]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 13 13:00:00 volumio volumio[1229]: Error: ENOTDIR: not a directory, scandir '/tmp/peppyrunning' Oct 13 13:00:00 volumio volumio[1229]: at Object.readdirSync (fs.js:1048:3) Oct 13 13:00:00 volumio volumio[1229]: at rmkidsSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:349:11) Oct 13 13:00:00 volumio volumio[1229]: at rmdirSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:342:7) Oct 13 13:00:00 volumio volumio[1229]: at Function.rimrafSync [as sync] (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:319:62) Oct 13 13:00:00 volumio volumio[1229]: at Object.removeSync (/data/plugins/user_interface/peppy_screensaver/node_modules/fs-extra/lib/remove/index.js:4:17) Oct 13 13:00:00 volumio volumio[1229]: at Socket. (/data/plugins/user_interface/peppy_screensaver/index.js:225:48) Oct 13 13:00:00 volumio volumio[1229]: at Socket.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Oct 13 13:00:00 volumio volumio[1229]: at Socket.onevent (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:278:10) Oct 13 13:00:00 volumio volumio[1229]: at Socket.onpacket (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:236:12) Oct 13 13:00:00 volumio volumio[1229]: at Manager. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15) Oct 13 13:00:00 volumio volumio[1229]: at Manager.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Oct 13 13:00:00 volumio volumio[1229]: at Manager.ondecoded (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:349:8) Oct 13 13:00:00 volumio volumio[1229]: at Decoder. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15) Oct 13 13:00:00 volumio volumio[1229]: at Decoder.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Oct 13 13:00:00 volumio volumio[1229]: at Decoder.add (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-parser/index.js:251:12) Oct 13 13:00:00 volumio volumio[1229]: at Manager.ondata (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:339:16) { Oct 13 13:00:00 volumio volumio[1229]: errno: -20, Oct 13 13:00:00 volumio volumio[1229]: syscall: 'scandir', Oct 13 13:00:00 volumio volumio[1229]: code: 'ENOTDIR', Oct 13 13:00:00 volumio volumio[1229]: path: '/tmp/peppyrunning' Oct 13 13:00:00 volumio volumio[1229]: } Oct 13 13:00:00 volumio volumio[1229]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 13 13:00:01 volumio sudo[2924]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-13 12:59 Oct 13 13:00:01 volumio sudo[2924]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:33:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="ee834e1c2a28de3c5d8c48611ecf1167"