Nov 03 15:41:00 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::volumioGetState Nov 03 15:41:00 volumio-pi4-test volumio[1266]: info: CorePlayQueue::getTrack 0 Nov 03 15:41:00 volumio-pi4-test volumio[1266]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Nov 03 15:41:00 volumio-pi4-test volumio[1266]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Nov 03 15:41:00 volumio-pi4-test volumio[1266]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Nov 03 15:41:00 volumio-pi4-test volumio[1266]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Nov 03 15:41:00 volumio-pi4-test volumio[1266]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Nov 03 15:41:00 volumio-pi4-test volumio[1266]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Nov 03 15:41:00 volumio-pi4-test volumio[1266]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Nov 03 15:41:00 volumio-pi4-test volumio[1266]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Nov 03 15:41:00 volumio-pi4-test volumio[1266]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Nov 03 15:41:00 volumio-pi4-test volumio[1266]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Nov 03 15:41:00 volumio-pi4-test volumio[1266]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Nov 03 15:41:00 volumio-pi4-test volumio[1266]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Nov 03 15:41:00 volumio-pi4-test volumio[1266]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Nov 03 15:41:00 volumio-pi4-test volumio[1266]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Nov 03 15:41:00 volumio-pi4-test volumio[1266]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Nov 03 15:41:00 volumio-pi4-test volumio[1266]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Nov 03 15:41:00 volumio-pi4-test volumio[1266]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Nov 03 15:41:00 volumio-pi4-test volumio[1266]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Nov 03 15:41:00 volumio-pi4-test volumio[1266]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Nov 03 15:41:00 volumio-pi4-test volumio[1266]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Nov 03 15:41:00 volumio-pi4-test volumio[1266]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Nov 03 15:41:00 volumio-pi4-test volumio[1266]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Nov 03 15:41:00 volumio-pi4-test volumio[1266]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Nov 03 15:41:00 volumio-pi4-test volumio[1266]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Nov 03 15:41:00 volumio-pi4-test volumio[1266]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Nov 03 15:41:00 volumio-pi4-test volumio[1266]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Nov 03 15:41:00 volumio-pi4-test volumio[1266]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Nov 03 15:41:00 volumio-pi4-test volumio[1266]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Nov 03 15:41:00 volumio-pi4-test volumio[1266]: info: Adding plugin bluetooth to MyMusic Plugins Nov 03 15:41:00 volumio-pi4-test volumio[1266]: info: Adding plugin multiroom to MyMusic Plugins Nov 03 15:41:00 volumio-pi4-test volumio[1266]: info: Adding plugin metavolumio to MyMusic Plugins Nov 03 15:41:00 volumio-pi4-test volumio[1266]: info: Adding plugin cd_controller to MyMusic Plugins Nov 03 15:41:00 volumio-pi4-test volumio[1266]: info: Adding plugin qobuzconnect to MyMusic Plugins Nov 03 15:41:00 volumio-pi4-test volumio[1266]: info: Adding plugin smart_inputs to MyMusic Plugins Nov 03 15:41:00 volumio-pi4-test volumio[1266]: info: Adding plugin tidalconnect to MyMusic Plugins Nov 03 15:41:01 volumio-pi4-test volumio[1266]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Nov 03 15:41:02 volumio-pi4-test upmpdcli[1613]: writing RSA key Nov 03 15:41:03 volumio-pi4-test volumio[1266]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Nov 03 15:41:03 volumio-pi4-test volumio[1266]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Nov 03 15:41:03 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 15:41:03 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 15:41:03 volumio-pi4-test volumio[1266]: info: Starting MyVolumio Remote Streaming Endpoints Nov 03 15:41:03 volumio-pi4-test volumio[1266]: info: MyVolumio login type: Token Nov 03 15:41:03 volumio-pi4-test volumio[1266]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Nov 03 15:41:03 volumio-pi4-test volumio[1266]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Nov 03 15:41:06 volumio-pi4-test volumio[1266]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Nov 03 15:41:06 volumio-pi4-test volumio[1266]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Nov 03 15:41:06 volumio-pi4-test volumio[1266]: info: Streaming services startup Nov 03 15:41:06 volumio-pi4-test volumio[1266]: info: Starting Streaming Daemon Nov 03 15:41:06 volumio-pi4-test volumio[1266]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Nov 03 15:41:06 volumio-pi4-test sudo[1622]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Nov 03 15:41:06 volumio-pi4-test sudo[1622]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 15:41:06 volumio-pi4-test systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Nov 03 15:41:06 volumio-pi4-test sudo[1622]: pam_unix(sudo:session): session closed for user root Nov 03 15:41:06 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 03 15:41:06 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 03 15:41:06 volumio-pi4-test volumio[1266]: error: Cannot start Volumio Streaming Daemon Nov 03 15:41:06 volumio-pi4-test volumio[1266]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Nov 03 15:41:06 volumio-pi4-test volumio[1266]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Nov 03 15:41:06 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 03 15:41:07 volumio-pi4-test volumio[1266]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Nov 03 15:41:08 volumio-pi4-test systemd[1]: setdatetime-helper.service: Deactivated successfully. Nov 03 15:41:08 volumio-pi4-test systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Nov 03 15:41:08 volumio-pi4-test volumio[1266]: info: MyVolumio token set successfully Nov 03 15:41:08 volumio-pi4-test volumio[1266]: info: MYVOLUMIO: Adding device Nov 03 15:41:08 volumio-pi4-test volumio[1266]: info: MYVOLUMIO: Evaluating Server Nov 03 15:41:09 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 03 15:41:09 volumio-pi4-test volumio[1266]: info: MyVolumio status changed Nov 03 15:41:09 volumio-pi4-test volumio[1266]: info: Streaming services startup Nov 03 15:41:09 volumio-pi4-test volumio[1266]: info: Starting Streaming Daemon Nov 03 15:41:09 volumio-pi4-test sudo[1671]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Nov 03 15:41:09 volumio-pi4-test sudo[1671]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 15:41:09 volumio-pi4-test volumio[1266]: info: Removing browser output: myVolumio user plan is not superstar Nov 03 15:41:09 volumio-pi4-test volumio[1266]: info: Removing audio output: Nov 03 15:41:09 volumio-pi4-test volumio[1266]: info: Stoppping Tunnel 1 Nov 03 15:41:09 volumio-pi4-test sudo[1671]: pam_unix(sudo:session): session closed for user root Nov 03 15:41:09 volumio-pi4-test volumio[1266]: error: Cannot start Volumio Streaming Daemon Nov 03 15:41:09 volumio-pi4-test volumio[1266]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Nov 03 15:41:09 volumio-pi4-test volumio[1266]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Nov 03 15:41:09 volumio-pi4-test sudo[1674]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Nov 03 15:41:09 volumio-pi4-test sudo[1674]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 15:41:09 volumio-pi4-test systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Nov 03 15:41:09 volumio-pi4-test systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Nov 03 15:41:09 volumio-pi4-test systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Nov 03 15:41:09 volumio-pi4-test systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Nov 03 15:41:09 volumio-pi4-test systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Nov 03 15:41:09 volumio-pi4-test systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Nov 03 15:41:09 volumio-pi4-test systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Nov 03 15:41:09 volumio-pi4-test systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Nov 03 15:41:09 volumio-pi4-test sudo[1674]: pam_unix(sudo:session): session closed for user root Nov 03 15:41:09 volumio-pi4-test volumio[1266]: info: Remote SSH Stopped Nov 03 15:41:09 volumio-pi4-test volumio[1266]: info: Setting Geolocation for MyVolumio to as1 Nov 03 15:41:09 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 15:41:09 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 15:41:09 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 15:41:10 volumio-pi4-test volumio[1266]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Nov 03 15:41:10 volumio-pi4-test volumio[1266]: info: Updating MyVolumio device info Nov 03 15:41:10 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 15:41:10 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 15:41:10 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 15:41:10 volumio-pi4-test sudo[1677]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 03 15:41:10 volumio-pi4-test sudo[1677]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 15:41:10 volumio-pi4-test sudo[1679]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 03 15:41:10 volumio-pi4-test sudo[1679]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 15:41:10 volumio-pi4-test sudo[1677]: pam_unix(sudo:session): session closed for user root Nov 03 15:41:10 volumio-pi4-test sudo[1679]: pam_unix(sudo:session): session closed for user root Nov 03 15:41:10 volumio-pi4-test volumio[1266]: verbose: New Socket.io Connection to 10.10.60.49 from 10.10.60.165 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::volumioGetState Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CorePlayQueue::getTrack 0 Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: Received Get System Info Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: Discovery: Getting this device information Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::volumioGetState Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CorePlayQueue::getTrack 0 Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::volumioGetState Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CorePlayQueue::getTrack 0 Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: Received Get System Info Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: Discovery: Getting this device information Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::volumioGetState Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CorePlayQueue::getTrack 0 Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::volumioGetState Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CorePlayQueue::getTrack 0 Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::volumioGetVisibleSources Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::volumioGetState Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CorePlayQueue::getTrack 0 Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::volumioGetState Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CorePlayQueue::getTrack 0 Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: Received Get System Info Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: Discovery: Getting this device information Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::volumioGetState Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CorePlayQueue::getTrack 0 Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::volumioGetState Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CorePlayQueue::getTrack 0 Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: Listing playlists Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: Received Get System Info Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: Discovery: Getting this device information Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::volumioGetState Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CorePlayQueue::getTrack 0 Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::volumioGetState Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CorePlayQueue::getTrack 0 Nov 03 15:41:11 volumio-pi4-test sudo[1685]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 03 15:41:11 volumio-pi4-test sudo[1685]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 15:41:11 volumio-pi4-test sudo[1684]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 03 15:41:11 volumio-pi4-test sudo[1684]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 15:41:11 volumio-pi4-test sudo[1685]: pam_unix(sudo:session): session closed for user root Nov 03 15:41:11 volumio-pi4-test sudo[1684]: pam_unix(sudo:session): session closed for user root Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Nov 03 15:41:11 volumio-pi4-test volumio[1266]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Nov 03 15:41:11 volumio-pi4-test volumio[1266]: verbose: New Socket.io Connection to 10.10.60.49 from 10.10.60.165 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::volumioGetState Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CorePlayQueue::getTrack 0 Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: Received Get System Info Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: Discovery: Getting this device information Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::volumioGetState Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CorePlayQueue::getTrack 0 Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::volumioGetState Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CorePlayQueue::getTrack 0 Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: Received Get System Info Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: Discovery: Getting this device information Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::volumioGetState Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CorePlayQueue::getTrack 0 Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::volumioGetState Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CorePlayQueue::getTrack 0 Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::volumioGetVisibleSources Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::volumioGetState Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CorePlayQueue::getTrack 0 Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::volumioGetState Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CorePlayQueue::getTrack 0 Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: Received Get System Info Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 03 15:41:11 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 03 15:41:12 volumio-pi4-test volumio[1266]: info: Discovery: Getting this device information Nov 03 15:41:12 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::volumioGetState Nov 03 15:41:12 volumio-pi4-test volumio[1266]: info: CorePlayQueue::getTrack 0 Nov 03 15:41:12 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 03 15:41:12 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::volumioGetState Nov 03 15:41:12 volumio-pi4-test volumio[1266]: info: CorePlayQueue::getTrack 0 Nov 03 15:41:12 volumio-pi4-test volumio[1266]: info: Listing playlists Nov 03 15:41:12 volumio-pi4-test volumio[1266]: info: Received Get System Info Nov 03 15:41:12 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 03 15:41:12 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 03 15:41:12 volumio-pi4-test volumio[1266]: info: Discovery: Getting this device information Nov 03 15:41:12 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::volumioGetState Nov 03 15:41:12 volumio-pi4-test volumio[1266]: info: CorePlayQueue::getTrack 0 Nov 03 15:41:12 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 03 15:41:12 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::volumioGetState Nov 03 15:41:12 volumio-pi4-test volumio[1266]: info: CorePlayQueue::getTrack 0 Nov 03 15:41:12 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Nov 03 15:41:13 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 03 15:41:13 volumio-pi4-test volumio[1266]: info: Received Get System Info Nov 03 15:41:13 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 03 15:41:13 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 03 15:41:13 volumio-pi4-test volumio[1266]: info: Discovery: Getting this device information Nov 03 15:41:13 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::volumioGetState Nov 03 15:41:13 volumio-pi4-test volumio[1266]: info: CorePlayQueue::getTrack 0 Nov 03 15:41:13 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 03 15:41:14 volumio-pi4-test volumio[1266]: info: MYVOLUMIO: Adding device Nov 03 15:41:14 volumio-pi4-test volumio[1266]: info: MYVOLUMIO: Evaluating Server Nov 03 15:41:14 volumio-pi4-test sudo[1705]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 03 15:41:14 volumio-pi4-test sudo[1705]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 15:41:14 volumio-pi4-test sudo[1705]: pam_unix(sudo:session): session closed for user root Nov 03 15:41:14 volumio-pi4-test sudo[1707]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 03 15:41:14 volumio-pi4-test sudo[1707]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 15:41:14 volumio-pi4-test sudo[1707]: pam_unix(sudo:session): session closed for user root Nov 03 15:41:14 volumio-pi4-test volumio[1266]: verbose: New Socket.io Connection to 10.10.60.49 from 10.10.60.165 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Nov 03 15:41:14 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::volumioGetState Nov 03 15:41:14 volumio-pi4-test volumio[1266]: info: CorePlayQueue::getTrack 0 Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: Setting Geolocation for MyVolumio to as1 Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: Received Get System Info Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: Discovery: Getting this device information Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::volumioGetState Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: CorePlayQueue::getTrack 0 Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::volumioGetState Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: CorePlayQueue::getTrack 0 Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: Received Get System Info Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: Discovery: Getting this device information Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::volumioGetState Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: CorePlayQueue::getTrack 0 Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::volumioGetState Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: CorePlayQueue::getTrack 0 Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::volumioGetVisibleSources Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::volumioGetState Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: CorePlayQueue::getTrack 0 Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::volumioGetState Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: CorePlayQueue::getTrack 0 Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: Received Get System Info Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: Discovery: Getting this device information Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::volumioGetState Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: CorePlayQueue::getTrack 0 Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::volumioGetState Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: CorePlayQueue::getTrack 0 Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: Listing playlists Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: Received Get System Info Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: Discovery: Getting this device information Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::volumioGetState Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: CorePlayQueue::getTrack 0 Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::volumioGetState Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: CorePlayQueue::getTrack 0 Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: Received Get System Info Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: Discovery: Getting this device information Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::volumioGetState Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: CorePlayQueue::getTrack 0 Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::volumioGetState Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: CorePlayQueue::getTrack 0 Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Nov 03 15:41:15 volumio-pi4-test volumio[1266]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::volumioGetState Nov 03 15:41:15 volumio-pi4-test volumio[1266]: info: CorePlayQueue::getTrack 0 Nov 03 15:41:16 volumio-pi4-test volumio[1266]: info: Updating MyVolumio device info Nov 03 15:41:16 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 15:41:16 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 15:41:16 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 15:41:16 volumio-pi4-test volumio[1266]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Nov 03 15:41:18 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 03 15:41:18 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 03 15:41:18 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Nov 03 15:41:18 volumio-pi4-test volumio[1266]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Nov 03 15:41:18 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::volumioGetState Nov 03 15:41:18 volumio-pi4-test volumio[1266]: info: CorePlayQueue::getTrack 0 Nov 03 15:41:18 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 03 15:41:18 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 15:41:18 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 03 15:41:18 volumio-pi4-test volumio-remote-updater[753]: Test mode enabled Nov 03 15:41:18 volumio-pi4-test volumio-remote-updater[753]: Alpha mode disabled Nov 03 15:41:18 volumio-pi4-test volumio-remote-updater[753]: Alpha legacy test mode disabled Nov 03 15:41:18 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Nov 03 15:41:19 volumio-pi4-test volumio[1266]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Nov 03 15:41:19 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Nov 03 15:41:20 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 03 15:41:21 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 03 15:41:23 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 15:41:23 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 15:41:23 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Nov 03 15:41:23 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Nov 03 15:41:23 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Nov 03 15:41:23 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::volumioGetBrowseSources Nov 03 15:41:23 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 03 15:41:23 volumio-pi4-test volumio[1266]: info: Enabling plugin touch_display Nov 03 15:41:23 volumio-pi4-test volumio[1266]: info: Loading plugin "touch_display"... Nov 03 15:41:24 volumio-pi4-test volumio[1266]: info: PLUGIN START: touch_display Nov 03 15:41:24 volumio-pi4-test volumio[1266]: info: Loading i18n strings for locale en Nov 03 15:41:24 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 03 15:41:24 volumio-pi4-test sudo[1747]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service Nov 03 15:41:24 volumio-pi4-test sudo[1747]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 15:41:24 volumio-pi4-test volumio[1266]: info: touch_display: No backlight interface detected. Nov 03 15:41:24 volumio-pi4-test volumio[1266]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Nov 03 15:41:24 volumio-pi4-test sudo[1749]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service Nov 03 15:41:24 volumio-pi4-test sudo[1749]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 15:41:24 volumio-pi4-test sudo[1752]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Nov 03 15:41:24 volumio-pi4-test sudo[1752]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 15:41:24 volumio-pi4-test systemd[1]: Stopping getty@tty1.service - Getty on tty1... Nov 03 15:41:24 volumio-pi4-test systemd[1]: getty@tty1.service: Deactivated successfully. Nov 03 15:41:24 volumio-pi4-test systemd[1]: Stopped getty@tty1.service - Getty on tty1. Nov 03 15:41:24 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 03 15:41:24 volumio-pi4-test systemd[1]: Reloading. Nov 03 15:41:24 volumio-pi4-test volumio[1266]: info: touch_display: No Raspberry Pi Foundation touch screen detected. Nov 03 15:41:24 volumio-pi4-test sudo[1756]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf Nov 03 15:41:25 volumio-pi4-test sudo[1756]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 15:41:25 volumio-pi4-test sudo[1756]: pam_unix(sudo:session): session closed for user root Nov 03 15:41:25 volumio-pi4-test volumio[1266]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set. Nov 03 15:41:25 volumio-pi4-test sudo[1747]: pam_unix(sudo:session): session closed for user root Nov 03 15:41:25 volumio-pi4-test sudo[1752]: pam_unix(sudo:session): session closed for user root Nov 03 15:41:25 volumio-pi4-test volumio[1266]: info: touch_display: systemctl stop getty@tty1.service succeeded. Nov 03 15:41:25 volumio-pi4-test volumio[1266]: info: touch_display: systemctl daemon-reload succeeded. Nov 03 15:41:25 volumio-pi4-test systemd[1]: Reloading. Nov 03 15:41:25 volumio-pi4-test sudo[1776]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Nov 03 15:41:26 volumio-pi4-test sudo[1776]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 15:41:26 volumio-pi4-test volumio[1266]: error: MyVolumio Plugin failed to authenticate in a timely fashion Nov 03 15:41:26 volumio-pi4-test volumio[1266]: info: Completed starting MyVolumio Plugin Nov 03 15:41:26 volumio-pi4-test volumio[1266]: [Metrics] CommandRouter: 47s 154.56ms Nov 03 15:41:26 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::volumiosetStartupVolume Nov 03 15:41:26 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 15:41:26 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 15:41:26 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::Close All Modals sent Nov 03 15:41:26 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::Close All Modals sent Nov 03 15:41:26 volumio-pi4-test sudo[1749]: pam_unix(sudo:session): session closed for user root Nov 03 15:41:26 volumio-pi4-test volumio[1266]: info: touch_display: systemctl disable getty@tty1.service succeeded. Nov 03 15:41:26 volumio-pi4-test systemd[1]: Started volumio-kiosk.service - Volumio Kiosk. Nov 03 15:41:26 volumio-pi4-test sudo[1776]: pam_unix(sudo:session): session closed for user root Nov 03 15:41:26 volumio-pi4-test volumio[1266]: info: touch_display: systemctl start volumio-kiosk.service succeeded. Nov 03 15:41:26 volumio-pi4-test volumio[1266]: info: touch_display: Volumio Kiosk started. Nov 03 15:41:26 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::volumioGetState Nov 03 15:41:26 volumio-pi4-test volumio[1266]: info: CorePlayQueue::getTrack 0 Nov 03 15:41:26 volumio-pi4-test startx[1815]: xauth: file /home/volumio/.Xauthority does not exist Nov 03 15:41:26 volumio-pi4-test volumio[1266]: info: Done. Nov 03 15:41:26 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::volumioGetState Nov 03 15:41:26 volumio-pi4-test volumio[1266]: info: CorePlayQueue::getTrack 0 Nov 03 15:41:26 volumio-pi4-test startx[1821]: X.Org X Server 1.21.1.7 Nov 03 15:41:26 volumio-pi4-test startx[1821]: X Protocol Version 11, Revision 0 Nov 03 15:41:26 volumio-pi4-test startx[1821]: Current Operating System: Linux volumio-pi4-test 6.12.47-v7l+ #1904 SMP Mon Sep 15 13:08:10 BST 2025 armv7l Nov 03 15:41:26 volumio-pi4-test startx[1821]: Kernel command line: coherent_pool=1M 8250.nr_uarts=0 snd_bcm2835.enable_headphones=0 cgroup_disable=memory numa_policy=interleave nvme.max_host_mem_size_mb=0 snd_bcm2835.enable_headphones=1 snd_bcm2835.enable_hdmi=1 snd_bcm2835.enable_hdmi=0 video=HDMI-A-1:1280x800M@60D video=HDMI-A-2:3840x2160M@30D numa=fake=2 system_heap.max_order=0 smsc95xx.macaddr=D8:3A:DD:D6:16:8C vc_mem.mem_base=0x3eb00000 vc_mem.mem_size=0x3ff00000 splash plymouth.ignore-serial-consoles dwc_otg.fiq_enable=1 dwc_otg.fiq_fsm_enable=1 dwc_otg.fiq_fsm_mask=0xF dwc_otg.nak_holdoff=1 quiet console=ttyS0,115200 console=tty1 imgpart=UUID=78d948c3-935b-4358-b7df-c382779bbef9 imgfile=/volumio_current.sqsh bootpart=UUID=A1E8-5028 datapart=UUID=60f254d7-c70a-4b55-956c-3df3766a56af uuidconfig=cmdline.txt pcie_aspm=off pci=pcie_bus_safe rootwait bootdelay=7 logo.nologo vt.global_cursor_default=0 net.ifnames=0 snd-bcm2835.enable_compat_alsa= snd_bcm2835.enable_hdmi=1 snd_bcm2835.enable_headphones=1 loglevel=0 nodebug use_kmsg=no Nov 03 15:41:26 volumio-pi4-test startx[1821]: xorg-server 2:21.1.7-3+rpt3+deb12u10 (https://www.debian.org/support) Nov 03 15:41:26 volumio-pi4-test startx[1821]: Current version of pixman: 0.44.0 Nov 03 15:41:26 volumio-pi4-test startx[1821]: Before reporting problems, check http://wiki.x.org Nov 03 15:41:26 volumio-pi4-test startx[1821]: to make sure that you have the latest version. Nov 03 15:41:26 volumio-pi4-test startx[1821]: Markers: (--) probed, (**) from config file, (==) default setting, Nov 03 15:41:26 volumio-pi4-test startx[1821]: (++) from command line, (!!) notice, (II) informational, Nov 03 15:41:26 volumio-pi4-test startx[1821]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Nov 03 15:41:26 volumio-pi4-test startx[1821]: (==) Log file: "/var/log/Xorg.0.log", Time: Mon Nov 3 15:41:26 2025 Nov 03 15:41:26 volumio-pi4-test startx[1821]: (==) Using config directory: "/etc/X11/xorg.conf.d" Nov 03 15:41:26 volumio-pi4-test startx[1821]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Nov 03 15:41:27 volumio-pi4-test volumio[1266]: info: touch_display: X display number found: 0 Nov 03 15:41:27 volumio-pi4-test volumio[1266]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Nov 03 15:41:27 volumio-pi4-test volumio[1266]: info: touch_display: X display number found: 0 Nov 03 15:41:27 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Nov 03 15:41:27 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 03 15:41:27 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Nov 03 15:41:33 volumio-pi4-test volumio[1266]: info: BOOT COMPLETED Nov 03 15:41:37 volumio-pi4-test kernel: vc4-drm gpu: [drm] *ERROR* [CRTC:100:pixelvalve-2] flip_done timed out Nov 03 15:41:47 volumio-pi4-test kernel: vc4-drm gpu: [drm] *ERROR* flip_done timed out Nov 03 15:41:47 volumio-pi4-test kernel: vc4-drm gpu: [drm] *ERROR* [CRTC:100:pixelvalve-2] commit wait timed out Nov 03 15:41:50 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 03 15:41:50 volumio-pi4-test volumio[1266]: info: touch_display: About to detect HDMI ports... Nov 03 15:41:50 volumio-pi4-test volumio[1266]: info: touch_display: Detected HDMI ports: HDMI 0 (HDMI-A-1), HDMI 1 (HDMI-A-2) Nov 03 15:41:55 volumio-pi4-test volumio[1266]: info: CALLMETHOD: user_interface touch_display saveScreensaverConf [object Object] Nov 03 15:41:55 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: touch_display , saveScreensaverConf Nov 03 15:41:55 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::volumioGetState Nov 03 15:41:55 volumio-pi4-test volumio[1266]: info: CorePlayQueue::getTrack 0 Nov 03 15:41:57 volumio-pi4-test kernel: vc4-drm gpu: [drm] *ERROR* flip_done timed out Nov 03 15:41:57 volumio-pi4-test kernel: vc4-drm gpu: [drm] *ERROR* [CONNECTOR:33:HDMI-A-1] commit wait timed out Nov 03 15:42:07 volumio-pi4-test kernel: vc4-drm gpu: [drm] *ERROR* flip_done timed out Nov 03 15:42:07 volumio-pi4-test kernel: vc4-drm gpu: [drm] *ERROR* [PLANE:89:plane-3] commit wait timed out Nov 03 15:42:11 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 03 15:42:11 volumio-pi4-test volumio[1266]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Nov 03 15:42:14 volumio-pi4-test sudo[1912]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/95-touch_display-plugin.conf Nov 03 15:42:14 volumio-pi4-test sudo[1912]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 15:42:14 volumio-pi4-test sudo[1912]: pam_unix(sudo:session): session closed for user root Nov 03 15:42:15 volumio-pi4-test sudo[1915]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start getty@tty1.service Nov 03 15:42:15 volumio-pi4-test sudo[1915]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 15:42:15 volumio-pi4-test volumio[1266]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/95-touch_display-plugin.conf set. Nov 03 15:42:15 volumio-pi4-test volumio[1266]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 03 15:42:15 volumio-pi4-test sudo[1917]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl enable getty@tty1.service Nov 03 15:42:15 volumio-pi4-test sudo[1917]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 15:42:15 volumio-pi4-test volumio[1266]: TypeError: Cannot read properties of undefined (reading 'split') Nov 03 15:42:15 volumio-pi4-test volumio[1266]: at /data/plugins/user_interface/touch_display/index.js:1274:37 Nov 03 15:42:15 volumio-pi4-test volumio[1266]: at ChildProcess.exithandler (node:child_process:413:7) Nov 03 15:42:15 volumio-pi4-test volumio[1266]: at ChildProcess.emit (node:events:514:28) Nov 03 15:42:15 volumio-pi4-test volumio[1266]: at maybeClose (node:internal/child_process:1105:16) Nov 03 15:42:15 volumio-pi4-test volumio[1266]: at ChildProcess._handle.onexit (node:internal/child_process:305:5) Nov 03 15:42:15 volumio-pi4-test volumio[1266]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 03 15:42:15 volumio-pi4-test sudo[1919]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumio-kiosk.service Nov 03 15:42:15 volumio-pi4-test sudo[1919]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 03 15:42:17 volumio-pi4-test sudo[1938]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-11-03 15:41' Nov 03 15:42:17 volumio-pi4-test sudo[1938]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="5ef3d56f987d109f3e21bfa246dbbb723cf6a917" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="c7bff9654d2984a81c5720476c2c8ac531869c54" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Oct 9 18:08:11 UTC 2025" VOLUMIO_VERSION="4.062" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="00524295c246b7d72f125e4c54b86a88"