Jun 20 18:11:03 volumio-vm startx[7722]: xinit: giving up
Jun 20 18:11:03 volumio-vm startx[7722]: xinit: unable to connect to X server: Connection refused
Jun 20 18:11:03 volumio-vm startx[7722]: xinit: server error
Jun 20 18:11:03 volumio-vm systemd[1]: volumio-kiosk.service: Main process exited, code=exited, status=1/FAILURE
Jun 20 18:11:03 volumio-vm systemd[1]: volumio-kiosk.service: Failed with result 'exit-code'.
Jun 20 18:11:08 volumio-vm systemd[1]: volumio-kiosk.service: Scheduled restart job, restart counter is at 48.
Jun 20 18:11:08 volumio-vm systemd[1]: Stopped volumio-kiosk.service - Start Volumio Kiosk.
Jun 20 18:11:08 volumio-vm systemd[1]: Started volumio-kiosk.service - Start Volumio Kiosk.
Jun 20 18:11:08 volumio-vm startx[7798]: X.Org X Server 1.21.1.7
Jun 20 18:11:08 volumio-vm startx[7798]: X Protocol Version 11, Revision 0
Jun 20 18:11:08 volumio-vm startx[7798]: Current Operating System: Linux volumio-vm 6.12.30-volumio #2 SMP PREEMPT_DYNAMIC Wed May 28 19:37:30 BST 2025 x86_64
Jun 20 18:11:08 volumio-vm startx[7798]: Kernel command line: BOOT_IMAGE=vmlinuz initramfs.clear splash plymouth.ignore-serial-consoles quiet loglevel=0 biosdevname=0 imgpart=UUID=fe897e9c-0d5f-4cba-bc7b-576cf9309cc2 bootpart=UUID=E667-2E51 datapart=UUID=9654a8ab-19c6-439c-9b73-299d49ed7131 hwdevice=x86 uuidconfig=syslinux.cfg,efi/BOOT/grub.cfg imgfile=/volumio_current.sqsh logo.nologo vt.global_cursor_default=0 acpi_backlight=vendor net.ifnames=0 use_kmsg=no initrd=volumio.initrd
Jun 20 18:11:08 volumio-vm startx[7798]: xorg-server 2:21.1.7-3+deb12u9 (https://www.debian.org/support)
Jun 20 18:11:08 volumio-vm startx[7798]: Current version of pixman: 0.42.2
Jun 20 18:11:08 volumio-vm startx[7798]: Before reporting problems, check http://wiki.x.org
Jun 20 18:11:08 volumio-vm startx[7798]: to make sure that you have the latest version.
Jun 20 18:11:08 volumio-vm startx[7798]: Markers: (--) probed, (**) from config file, (==) default setting,
Jun 20 18:11:08 volumio-vm startx[7798]: (++) from command line, (!!) notice, (II) informational,
Jun 20 18:11:08 volumio-vm startx[7798]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown.
Jun 20 18:11:08 volumio-vm startx[7798]: (==) Log file: "/var/log/Xorg.0.log", Time: Fri Jun 20 18:11:08 2025
Jun 20 18:11:08 volumio-vm startx[7798]: (==) Using system config directory "/usr/share/X11/xorg.conf.d"
Jun 20 18:11:08 volumio-vm startx[7798]: vesa: Ignoring device with a bound kernel driver
Jun 20 18:11:08 volumio-vm startx[7798]: (EE)
Jun 20 18:11:08 volumio-vm startx[7798]: Fatal server error:
Jun 20 18:11:08 volumio-vm startx[7798]: (EE) no screens found(EE)
Jun 20 18:11:08 volumio-vm startx[7798]: (EE)
Jun 20 18:11:08 volumio-vm startx[7798]: Please consult the The X.Org Foundation support
Jun 20 18:11:08 volumio-vm startx[7798]: at http://wiki.x.org
Jun 20 18:11:08 volumio-vm startx[7798]: for help.
Jun 20 18:11:08 volumio-vm startx[7798]: (EE) Please also check the log file at "/var/log/Xorg.0.log" for additional information.
Jun 20 18:11:08 volumio-vm startx[7798]: (EE)
Jun 20 18:11:08 volumio-vm startx[7798]: (EE) Server terminated with error (1). Closing log file.
Jun 20 18:11:12 volumio-vm systemd[1]: systemd-timedated.service: Deactivated successfully.
Jun 20 18:11:17 volumio-vm volumio[6227]: info: CoreCommandRouter::volumioGetState
Jun 20 18:11:18 volumio-vm volumio[6227]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 20 18:11:18 volumio-vm volumio[6227]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 20 18:11:18 volumio-vm volumio[6227]: info: Retrieving Cloud Streaming UI
Jun 20 18:11:18 volumio-vm volumio[6227]: info: Getting Tidal Cloud Configuration
Jun 20 18:11:18 volumio-vm volumio[6227]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 20 18:11:18 volumio-vm volumio[6227]: info: Getting Qobuz Cloud Configuration
Jun 20 18:11:18 volumio-vm volumio[6227]: info: Asking plugin for UI Config
Jun 20 18:11:18 volumio-vm volumio[6227]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 20 18:11:18 volumio-vm volumio[6227]: info: Getting Spotify Cloud Configuration
Jun 20 18:11:18 volumio-vm volumio[6227]: info: Asking plugin for UI Config
Jun 20 18:11:18 volumio-vm volumio[6227]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 20 18:11:18 volumio-vm volumio[6227]: info: Saving Spotify Acccount
Jun 20 18:11:18 volumio-vm volumio[6227]: info: Got it
Jun 20 18:11:18 volumio-vm volumio[6227]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Jun 20 18:11:18 volumio-vm volumio[6227]: info: Got Tidal Cloud Configuration
Jun 20 18:11:18 volumio-vm volumio[6227]: info: Got it
Jun 20 18:11:18 volumio-vm volumio[6227]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 20 18:11:18 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Jun 20 18:11:18 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Jun 20 18:11:18 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Jun 20 18:11:18 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Jun 20 18:11:18 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 20 18:11:18 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 20 18:11:18 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 20 18:11:18 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 20 18:11:18 volumio-vm volumio[6227]: info: CoreCommandRouter::volumioGetBrowseSources
Jun 20 18:11:18 volumio-vm volumio[6227]: info: CoreCommandRouter::volumioGetBrowseSources
Jun 20 18:11:18 volumio-vm volumio[6227]: info: CoreCommandRouter::volumioGetBrowseSources
Jun 20 18:11:18 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jun 20 18:11:18 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Jun 20 18:11:19 volumio-vm volumio[6227]: info: Executing endpoint metavolumio
Jun 20 18:11:19 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Jun 20 18:11:22 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jun 20 18:11:23 volumio-vm startx[7797]: xinit: giving up
Jun 20 18:11:23 volumio-vm startx[7797]: xinit: unable to connect to X server: Connection refused
Jun 20 18:11:23 volumio-vm startx[7797]: xinit: server error
Jun 20 18:11:23 volumio-vm systemd[1]: volumio-kiosk.service: Main process exited, code=exited, status=1/FAILURE
Jun 20 18:11:23 volumio-vm systemd[1]: volumio-kiosk.service: Failed with result 'exit-code'.
Jun 20 18:11:28 volumio-vm systemd[1]: volumio-kiosk.service: Scheduled restart job, restart counter is at 49.
Jun 20 18:11:28 volumio-vm systemd[1]: Stopped volumio-kiosk.service - Start Volumio Kiosk.
Jun 20 18:11:28 volumio-vm systemd[1]: Started volumio-kiosk.service - Start Volumio Kiosk.
Jun 20 18:11:28 volumio-vm startx[7874]: X.Org X Server 1.21.1.7
Jun 20 18:11:28 volumio-vm startx[7874]: X Protocol Version 11, Revision 0
Jun 20 18:11:28 volumio-vm startx[7874]: Current Operating System: Linux volumio-vm 6.12.30-volumio #2 SMP PREEMPT_DYNAMIC Wed May 28 19:37:30 BST 2025 x86_64
Jun 20 18:11:28 volumio-vm startx[7874]: Kernel command line: BOOT_IMAGE=vmlinuz initramfs.clear splash plymouth.ignore-serial-consoles quiet loglevel=0 biosdevname=0 imgpart=UUID=fe897e9c-0d5f-4cba-bc7b-576cf9309cc2 bootpart=UUID=E667-2E51 datapart=UUID=9654a8ab-19c6-439c-9b73-299d49ed7131 hwdevice=x86 uuidconfig=syslinux.cfg,efi/BOOT/grub.cfg imgfile=/volumio_current.sqsh logo.nologo vt.global_cursor_default=0 acpi_backlight=vendor net.ifnames=0 use_kmsg=no initrd=volumio.initrd
Jun 20 18:11:28 volumio-vm startx[7874]: xorg-server 2:21.1.7-3+deb12u9 (https://www.debian.org/support)
Jun 20 18:11:28 volumio-vm startx[7874]: Current version of pixman: 0.42.2
Jun 20 18:11:28 volumio-vm startx[7874]: Before reporting problems, check http://wiki.x.org
Jun 20 18:11:28 volumio-vm startx[7874]: to make sure that you have the latest version.
Jun 20 18:11:28 volumio-vm startx[7874]: Markers: (--) probed, (**) from config file, (==) default setting,
Jun 20 18:11:28 volumio-vm startx[7874]: (++) from command line, (!!) notice, (II) informational,
Jun 20 18:11:28 volumio-vm startx[7874]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown.
Jun 20 18:11:28 volumio-vm startx[7874]: (==) Log file: "/var/log/Xorg.0.log", Time: Fri Jun 20 18:11:28 2025
Jun 20 18:11:28 volumio-vm startx[7874]: (==) Using system config directory "/usr/share/X11/xorg.conf.d"
Jun 20 18:11:28 volumio-vm startx[7874]: vesa: Ignoring device with a bound kernel driver
Jun 20 18:11:28 volumio-vm startx[7874]: (EE)
Jun 20 18:11:28 volumio-vm startx[7874]: Fatal server error:
Jun 20 18:11:28 volumio-vm startx[7874]: (EE) no screens found(EE)
Jun 20 18:11:28 volumio-vm startx[7874]: (EE)
Jun 20 18:11:28 volumio-vm startx[7874]: Please consult the The X.Org Foundation support
Jun 20 18:11:28 volumio-vm startx[7874]: at http://wiki.x.org
Jun 20 18:11:28 volumio-vm startx[7874]: for help.
Jun 20 18:11:28 volumio-vm startx[7874]: (EE) Please also check the log file at "/var/log/Xorg.0.log" for additional information.
Jun 20 18:11:28 volumio-vm startx[7874]: (EE)
Jun 20 18:11:28 volumio-vm startx[7874]: (EE) Server terminated with error (1). Closing log file.
Jun 20 18:11:41 volumio-vm volumio[6227]: info: Received OAUTH Data
Jun 20 18:11:41 volumio-vm volumio[6227]: info: Refreshing TIDAL token
Jun 20 18:11:41 volumio-vm sudo[7904]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jun 20 18:11:41 volumio-vm sudo[7904]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jun 20 18:11:41 volumio-vm sudo[7906]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jun 20 18:11:41 volumio-vm sudo[7906]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jun 20 18:11:41 volumio-vm sudo[7904]: pam_unix(sudo:session): session closed for user root
Jun 20 18:11:41 volumio-vm sudo[7906]: pam_unix(sudo:session): session closed for user root
Jun 20 18:11:41 volumio-vm volumio[6227]: verbose: New Socket.io Connection to 192.168.100.217 from 192.168.100.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5
Jun 20 18:11:41 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jun 20 18:11:41 volumio-vm volumio[6227]: info: CoreCommandRouter::volumioGetVisibleSources
Jun 20 18:11:41 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 20 18:11:41 volumio-vm volumio[6227]: info: CoreCommandRouter::volumioGetState
Jun 20 18:11:41 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Jun 20 18:11:41 volumio-vm volumio[6227]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 20 18:11:41 volumio-vm volumio[6227]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 20 18:11:41 volumio-vm volumio[6227]: info: Retrieving Cloud Streaming UI
Jun 20 18:11:41 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jun 20 18:11:41 volumio-vm volumio[6227]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Jun 20 18:11:41 volumio-vm volumio[6227]: info: Received Get System Info
Jun 20 18:11:41 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 20 18:11:41 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 20 18:11:41 volumio-vm volumio[6227]: info: Discovery: Getting this device information
Jun 20 18:11:41 volumio-vm volumio[6227]: info: CoreCommandRouter::volumioGetState
Jun 20 18:11:41 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 20 18:11:41 volumio-vm volumio[6227]: info: CoreCommandRouter::volumioGetState
Jun 20 18:11:41 volumio-vm volumio[6227]: info: Listing playlists
Jun 20 18:11:41 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Jun 20 18:11:41 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jun 20 18:11:41 volumio-vm volumio[6227]: info: Getting Tidal Cloud Configuration
Jun 20 18:11:41 volumio-vm volumio[6227]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 20 18:11:41 volumio-vm volumio[6227]: info: Getting Qobuz Cloud Configuration
Jun 20 18:11:41 volumio-vm volumio[6227]: info: Asking plugin for UI Config
Jun 20 18:11:41 volumio-vm volumio[6227]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 20 18:11:41 volumio-vm volumio[6227]: info: Getting Spotify Cloud Configuration
Jun 20 18:11:41 volumio-vm volumio[6227]: info: Asking plugin for UI Config
Jun 20 18:11:41 volumio-vm volumio[6227]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 20 18:11:41 volumio-vm volumio[6227]: info: Saving Spotify Acccount
Jun 20 18:11:41 volumio-vm volumio[6227]: info: Got it
Jun 20 18:11:41 volumio-vm volumio[6227]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Jun 20 18:11:41 volumio-vm volumio[6227]: info: TIDAL Access Token successfully retrieved
Jun 20 18:11:41 volumio-vm volumio[6227]: info: Got Tidal Cloud Configuration
Jun 20 18:11:41 volumio-vm volumio[6227]: info: Got it
Jun 20 18:11:41 volumio-vm volumio[6227]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 20 18:11:41 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Jun 20 18:11:41 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Jun 20 18:11:41 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Jun 20 18:11:41 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Jun 20 18:11:41 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 20 18:11:41 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 20 18:11:41 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 20 18:11:41 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 20 18:11:41 volumio-vm volumio[6227]: info: CoreCommandRouter::volumioGetBrowseSources
Jun 20 18:11:41 volumio-vm volumio[6227]: info: CoreCommandRouter::volumioGetBrowseSources
Jun 20 18:11:41 volumio-vm volumio[6227]: info: CoreCommandRouter::volumioGetBrowseSources
Jun 20 18:11:41 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jun 20 18:11:41 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Jun 20 18:11:41 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Jun 20 18:11:42 volumio-vm volumio[6227]: info: Successfully retrieved User Session From TIDAL
Jun 20 18:11:42 volumio-vm volumio[6227]: info: Adding TIDAL to Browse Sources
Jun 20 18:11:42 volumio-vm volumio[6227]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jun 20 18:11:42 volumio-vm volumio[6227]: info: [1750435902005] CoreMusicLibrary::Adding element TIDAL
Jun 20 18:11:42 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 20 18:11:42 volumio-vm volumio[6227]: Cannot find translation for source HDA Intel
Jun 20 18:11:42 volumio-vm volumio[6227]: Cannot find translation for source TIDAL
Jun 20 18:11:42 volumio-vm volumio[6227]: info: Successfully retrieved User Subscription From TIDAL
Jun 20 18:11:42 volumio-vm volumio[6227]: Configuration write error: Error: ENOENT: no such file or directory, open '/data/configuration/music_service/tidal/config.json'
Jun 20 18:11:43 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Jun 20 18:11:43 volumio-vm startx[7873]: xinit: giving up
Jun 20 18:11:43 volumio-vm startx[7873]: xinit: unable to connect to X server: Connection refused
Jun 20 18:11:43 volumio-vm startx[7873]: xinit: server error
Jun 20 18:11:43 volumio-vm systemd[1]: volumio-kiosk.service: Main process exited, code=exited, status=1/FAILURE
Jun 20 18:11:43 volumio-vm systemd[1]: volumio-kiosk.service: Failed with result 'exit-code'.
Jun 20 18:11:43 volumio-vm systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service...
Jun 20 18:11:43 volumio-vm dbus-daemon[789]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.231' (uid=0 pid=7930 comm="timedatectl show --property=NTPSynchronized --valu")
Jun 20 18:11:43 volumio-vm systemd[1]: Starting systemd-timedated.service - Time & Date Service...
Jun 20 18:11:43 volumio-vm dbus-daemon[789]: [system] Successfully activated service 'org.freedesktop.timedate1'
Jun 20 18:11:43 volumio-vm systemd[1]: Started systemd-timedated.service - Time & Date Service.
Jun 20 18:11:43 volumio-vm setdatetime-helper.sh[7929]: Time is not synchronized. Attempting to sync...
Jun 20 18:11:43 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jun 20 18:11:43 volumio-vm volumio[6227]: info: Received Get System Info
Jun 20 18:11:43 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 20 18:11:43 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 20 18:11:43 volumio-vm volumio[6227]: info: Discovery: Getting this device information
Jun 20 18:11:43 volumio-vm volumio[6227]: info: CoreCommandRouter::volumioGetState
Jun 20 18:11:43 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 20 18:11:43 volumio-vm sudo[7938]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/date -s 'Fri, 20 Jun 2025 16:11:44 GMT#015'
Jun 20 18:11:43 volumio-vm sudo[7938]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Jun 20 18:11:44 volumio-vm setdatetime-helper.sh[7939]: Fri Jun 20 18:11:44 CEST 2025
Jun 20 18:11:44 volumio-vm sudo[7938]: pam_unix(sudo:session): session closed for user root
Jun 20 18:11:44 volumio-vm setdatetime-helper.sh[7929]: Time synchronized successfully.
Jun 20 18:11:44 volumio-vm systemd[1]: setdatetime-helper.timer.service: Deactivated successfully.
Jun 20 18:11:44 volumio-vm systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service.
Jun 20 18:11:44 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jun 20 18:11:44 volumio-vm volumio[6227]: info: Received Get System Info
Jun 20 18:11:44 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 20 18:11:45 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 20 18:11:45 volumio-vm volumio[6227]: info: Discovery: Getting this device information
Jun 20 18:11:45 volumio-vm volumio[6227]: info: CoreCommandRouter::volumioGetState
Jun 20 18:11:45 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 20 18:11:45 volumio-vm volumio[6227]: info: CoreCommandRouter::volumioGetState
Jun 20 18:11:47 volumio-vm volumio[6227]: info: CoreCommandRouter::volumioGetQueue
Jun 20 18:11:47 volumio-vm volumio[6227]: info: CoreStateMachine::getQueue
Jun 20 18:11:47 volumio-vm volumio[6227]: info: CorePlayQueue::getQueue
Jun 20 18:11:47 volumio-vm volumio[6227]: info: Executing endpoint metavolumio
Jun 20 18:11:47 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Jun 20 18:11:48 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri
Jun 20 18:11:48 volumio-vm volumio[6227]: info: browseTIDALUri took 193 milliseconds
Jun 20 18:11:48 volumio-vm volumio[6227]: info: Preload queue cleared
Jun 20 18:11:48 volumio-vm volumio[6227]: info: Preload queue cleared
Jun 20 18:11:49 volumio-vm systemd[1]: volumio-kiosk.service: Scheduled restart job, restart counter is at 50.
Jun 20 18:11:49 volumio-vm systemd[1]: Stopped volumio-kiosk.service - Start Volumio Kiosk.
Jun 20 18:11:49 volumio-vm systemd[1]: Started volumio-kiosk.service - Start Volumio Kiosk.
Jun 20 18:11:49 volumio-vm startx[7969]: X.Org X Server 1.21.1.7
Jun 20 18:11:49 volumio-vm startx[7969]: X Protocol Version 11, Revision 0
Jun 20 18:11:49 volumio-vm startx[7969]: Current Operating System: Linux volumio-vm 6.12.30-volumio #2 SMP PREEMPT_DYNAMIC Wed May 28 19:37:30 BST 2025 x86_64
Jun 20 18:11:49 volumio-vm startx[7969]: Kernel command line: BOOT_IMAGE=vmlinuz initramfs.clear splash plymouth.ignore-serial-consoles quiet loglevel=0 biosdevname=0 imgpart=UUID=fe897e9c-0d5f-4cba-bc7b-576cf9309cc2 bootpart=UUID=E667-2E51 datapart=UUID=9654a8ab-19c6-439c-9b73-299d49ed7131 hwdevice=x86 uuidconfig=syslinux.cfg,efi/BOOT/grub.cfg imgfile=/volumio_current.sqsh logo.nologo vt.global_cursor_default=0 acpi_backlight=vendor net.ifnames=0 use_kmsg=no initrd=volumio.initrd
Jun 20 18:11:49 volumio-vm startx[7969]: xorg-server 2:21.1.7-3+deb12u9 (https://www.debian.org/support)
Jun 20 18:11:49 volumio-vm startx[7969]: Current version of pixman: 0.42.2
Jun 20 18:11:49 volumio-vm startx[7969]: Before reporting problems, check http://wiki.x.org
Jun 20 18:11:49 volumio-vm startx[7969]: to make sure that you have the latest version.
Jun 20 18:11:49 volumio-vm startx[7969]: Markers: (--) probed, (**) from config file, (==) default setting,
Jun 20 18:11:49 volumio-vm startx[7969]: (++) from command line, (!!) notice, (II) informational,
Jun 20 18:11:49 volumio-vm startx[7969]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown.
Jun 20 18:11:49 volumio-vm startx[7969]: (==) Log file: "/var/log/Xorg.0.log", Time: Fri Jun 20 18:11:49 2025
Jun 20 18:11:49 volumio-vm startx[7969]: (==) Using system config directory "/usr/share/X11/xorg.conf.d"
Jun 20 18:11:49 volumio-vm startx[7969]: vesa: Ignoring device with a bound kernel driver
Jun 20 18:11:49 volumio-vm startx[7969]: (EE)
Jun 20 18:11:49 volumio-vm startx[7969]: Fatal server error:
Jun 20 18:11:49 volumio-vm startx[7969]: (EE) no screens found(EE)
Jun 20 18:11:49 volumio-vm startx[7969]: (EE)
Jun 20 18:11:49 volumio-vm startx[7969]: Please consult the The X.Org Foundation support
Jun 20 18:11:49 volumio-vm startx[7969]: at http://wiki.x.org
Jun 20 18:11:49 volumio-vm startx[7969]: for help.
Jun 20 18:11:49 volumio-vm startx[7969]: (EE) Please also check the log file at "/var/log/Xorg.0.log" for additional information.
Jun 20 18:11:49 volumio-vm startx[7969]: (EE)
Jun 20 18:11:49 volumio-vm startx[7969]: (EE) Server terminated with error (1). Closing log file.
Jun 20 18:11:52 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Jun 20 18:12:00 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jun 20 18:12:00 volumio-vm volumio[6227]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Jun 20 18:12:00 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Jun 20 18:12:00 volumio-vm volumio[6227]: info: Received Get System Version
Jun 20 18:12:00 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jun 20 18:12:00 volumio-vm volumio[6227]: info: Received Get System Info
Jun 20 18:12:00 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 20 18:12:00 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 20 18:12:00 volumio-vm volumio[6227]: info: Discovery: Getting this device information
Jun 20 18:12:00 volumio-vm volumio[6227]: info: CoreCommandRouter::volumioGetState
Jun 20 18:12:00 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 20 18:12:04 volumio-vm startx[7968]: xinit: giving up
Jun 20 18:12:04 volumio-vm startx[7968]: xinit: unable to connect to X server: Connection refused
Jun 20 18:12:04 volumio-vm startx[7968]: xinit: server error
Jun 20 18:12:04 volumio-vm systemd[1]: volumio-kiosk.service: Main process exited, code=exited, status=1/FAILURE
Jun 20 18:12:04 volumio-vm systemd[1]: volumio-kiosk.service: Failed with result 'exit-code'.
Jun 20 18:12:05 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri
Jun 20 18:12:05 volumio-vm volumio[6227]: info: browseTIDALUri took 515 milliseconds
Jun 20 18:12:05 volumio-vm volumio[6227]: info: Preload queue cleared
Jun 20 18:12:09 volumio-vm volumio[6227]: Searching all installed plugins
Jun 20 18:12:09 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 20 18:12:09 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: , search
Jun 20 18:12:09 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: mpd , search
Jun 20 18:12:09 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search
Jun 20 18:12:09 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: last_100 , search
Jun 20 18:12:09 volumio-vm volumio[6227]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100
Jun 20 18:12:09 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: webradio , search
Jun 20 18:12:09 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: smart_inputs , search
Jun 20 18:12:09 volumio-vm volumio[6227]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin smart_inputs
Jun 20 18:12:09 volumio-vm volumio[6227]: info: CoreCommandRouter::executeOnPlugin: tidal , search
Jun 20 18:12:09 volumio-vm volumio[6227]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 20 18:12:09 volumio-vm volumio[6227]: TypeError: Cannot read properties of undefined (reading 'length')
Jun 20 18:12:09 volumio-vm volumio[6227]: at /volumio/node_modules/libxmljs/dist/lib/parse.js:186:126
Jun 20 18:12:09 volumio-vm volumio[6227]: at Object.parseXml (/volumio/node_modules/libxmljs/dist/lib/parse.js:185:49)
Jun 20 18:12:09 volumio-vm volumio[6227]: at /volumio/app/plugins/music_service/webradio/index.js:962:31
Jun 20 18:12:09 volumio-vm volumio[6227]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5)
Jun 20 18:12:09 volumio-vm volumio[6227]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 20 18:12:09 volumio-vm sudo[8035]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-06-20 18:11'
Jun 20 18:12:09 volumio-vm sudo[8035]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
PRETTY_NAME="Debian GNU/Linux 12 (bookworm)"
NAME="Debian GNU/Linux"
VERSION_ID="12"
VERSION="12 (bookworm)"
VERSION_CODENAME=bookworm
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="cee9bb5b0ee50e4898478097a64b5c6c77d5a212"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Sat Jun 14 07:01:29 UTC 2025"
VOLUMIO_VERSION="4.012"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="38c4f0e007cb9b6482e9f27bbe65b0b5"