Mar 24 12:07:04 volumio bluealsa[1070]: bluez.c:1290: Signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded(/org/bluez/hci0/dev_4D_B6_A8_CA_A8_48, ...)
Mar 24 12:07:04 volumio volumio[1328]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
Mar 24 12:07:04 volumio volumio[1328]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
Mar 24 12:07:04 volumio volumio[1328]: info: Streaming services startup
Mar 24 12:07:04 volumio volumio[1328]: info: Starting Streaming Daemon
Mar 24 12:07:05 volumio volumio[1328]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started
Mar 24 12:07:05 volumio upmpdcli[1803]: writing RSA key
Mar 24 12:07:05 volumio sudo[1798]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Mar 24 12:07:05 volumio sudo[1798]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Mar 24 12:07:05 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Mar 24 12:07:05 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 24 12:07:05 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Mar 24 12:07:05 volumio sudo[1798]: pam_unix(sudo:session): session closed for user root
Mar 24 12:07:05 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Mar 24 12:07:05 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Mar 24 12:07:05 volumio volumio[1328]: info: Received Get System Info
Mar 24 12:07:05 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 24 12:07:05 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 24 12:07:05 volumio volumio[1328]: info: Discovery: Getting this device information
Mar 24 12:07:05 volumio volumio[1328]: info: CoreCommandRouter::volumioGetState
Mar 24 12:07:05 volumio volumio[1328]: info: CorePlayQueue::getTrack 0
Mar 24 12:07:05 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 24 12:07:05 volumio volumio[1328]: error: Cannot start Volumio Streaming Daemon
Mar 24 12:07:05 volumio volumio[1328]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Mar 24 12:07:05 volumio volumio[1328]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Mar 24 12:07:05 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Mar 24 12:07:06 volumio volumio[1328]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5
Mar 24 12:07:08 volumio volumio-remote-updater[740]: Test mode disabled
Mar 24 12:07:08 volumio volumio-remote-updater[740]: Alpha mode disabled
Mar 24 12:07:08 volumio volumio-remote-updater[740]: Alpha legacy test mode disabled
Mar 24 12:07:08 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Mar 24 12:07:08 volumio volumio[1328]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN
Mar 24 12:07:08 volumio volumio[1328]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false}
Mar 24 12:07:08 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Mar 24 12:07:08 volumio volumio[1328]: info: CoreCommandRouter::volumioGetState
Mar 24 12:07:08 volumio volumio[1328]: info: CorePlayQueue::getTrack 0
Mar 24 12:07:09 volumio bluealsa[1070]: bluez.c:1393: Signal: org.freedesktop.DBus.ObjectManager.InterfacesRemoved(/org/bluez/hci0/dev_70_EF_85_30_77_ED, ...)
Mar 24 12:07:09 volumio volumio[1328]: info: MyVolumio token set successfully
Mar 24 12:07:09 volumio volumio[1328]: info: MYVOLUMIO: Adding device
Mar 24 12:07:09 volumio volumio[1328]: info: MYVOLUMIO: Evaluating Server
Mar 24 12:07:10 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 24 12:07:11 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 24 12:07:11 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Mar 24 12:07:11 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Mar 24 12:07:11 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Mar 24 12:07:11 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Mar 24 12:07:11 volumio volumio[1328]: info: CoreCommandRouter::volumioGetBrowseSources
Mar 24 12:07:11 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Mar 24 12:07:11 volumio volumio[1328]: info: MyVolumio status changed
Mar 24 12:07:11 volumio volumio5-onboarding[1643]: time=2026-03-24T12:07:11.137+01:00 level=INFO msg="app ready event" component=server event=CLIENT_EVENT_TYPE_APP_READY peer="192.168.1.207:52766 @ 0x2cc5140" latency=351.250289ms platform=PLATFORM_ANDROID version=5.260209.0
Mar 24 12:07:11 volumio volumio5-onboarding[1643]: time=2026-03-24T12:07:11.137+01:00 level=INFO msg="device data request" component=server type=REQUEST_TYPE_DEVICE_DATA peer="192.168.1.207:52766 @ 0x2cc5140" latency=350.575512ms timeout=10s
Mar 24 12:07:11 volumio volumio5-onboarding[1643]: time=2026-03-24T12:07:11.138+01:00 level=INFO msg="emitting device capabilities changed event" component=server peer="192.168.1.207:52766 @ 0x2cc5140"
Mar 24 12:07:11 volumio volumio[1328]: info: Streaming services startup
Mar 24 12:07:11 volumio volumio[1328]: info: Starting Streaming Daemon
Mar 24 12:07:11 volumio volumio[1328]: info: Removing browser output: myVolumio user plan is not superstar
Mar 24 12:07:11 volumio volumio[1328]: info: Removing audio output:
Mar 24 12:07:11 volumio volumio[1328]: info: Stoppping Tunnel 1
Mar 24 12:07:11 volumio bluealsa[1070]: bluez.c:1290: Signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded(/org/bluez/hci0/dev_71_B3_0B_DD_66_21, ...)
Mar 24 12:07:11 volumio sudo[1849]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Mar 24 12:07:11 volumio sudo[1849]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Mar 24 12:07:11 volumio sudo[1851]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service
Mar 24 12:07:11 volumio volumio[1328]: info: Setting Geolocation for MyVolumio to eu8
Mar 24 12:07:11 volumio sudo[1849]: pam_unix(sudo:session): session closed for user root
Mar 24 12:07:11 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 24 12:07:11 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 24 12:07:11 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 24 12:07:11 volumio volumio[1328]: info: Received Get System Info
Mar 24 12:07:11 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 24 12:07:11 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 24 12:07:11 volumio volumio[1328]: info: Discovery: Getting this device information
Mar 24 12:07:11 volumio volumio[1328]: info: CoreCommandRouter::volumioGetState
Mar 24 12:07:11 volumio volumio[1328]: info: CorePlayQueue::getTrack 0
Mar 24 12:07:11 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 24 12:07:11 volumio volumio5-onboarding[1643]: time=2026-03-24T12:07:11.659+01:00 level=INFO msg="emitting device name changed event" component=server peer="192.168.1.207:52766 @ 0x2cc5140" name=Volumio
Mar 24 12:07:11 volumio volumio5-onboarding[1643]: time=2026-03-24T12:07:11.666+01:00 level=INFO msg="emitting device language changed event" component=server peer="192.168.1.207:52766 @ 0x2cc5140" language=nl
Mar 24 12:07:11 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone
Mar 24 12:07:11 volumio sudo[1851]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Mar 24 12:07:11 volumio volumio5-onboarding[1643]: time=2026-03-24T12:07:11.690+01:00 level=INFO msg="emitting device timezone changed event" component=server peer="192.168.1.207:52766 @ 0x2cc5140" timezone=Europe/Amsterdam
Mar 24 12:07:11 volumio volumio5-onboarding[1643]: time=2026-03-24T12:07:11.692+01:00 level=INFO msg="emitting ethernet info changed event" component=server peer="192.168.1.207:52766 @ 0x2cc5140" available=true connected=true macAddress=dc:a6:32:11:14:dc ip4Address=192.168.1.41/24 ip6Address=
Mar 24 12:07:11 volumio volumio5-onboarding[1643]: time=2026-03-24T12:07:11.695+01:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.1.207:52766 @ 0x2cc5140" available=true connected=false macAddress= ip4Address= ip6Address= ssid=
Mar 24 12:07:11 volumio volumio5-onboarding[1643]: time=2026-03-24T12:07:11.697+01:00 level=INFO msg="emitting device setup status changed event" component=server peer="192.168.1.207:52766 @ 0x2cc5140" setupComplete=true
Mar 24 12:07:11 volumio volumio[1328]: error: Cannot start Volumio Streaming Daemon
Mar 24 12:07:11 volumio volumio[1328]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Mar 24 12:07:11 volumio volumio[1328]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Mar 24 12:07:11 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getExtendedOutputDevices
Mar 24 12:07:11 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Mar 24 12:07:11 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 24 12:07:11 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Mar 24 12:07:11 volumio volumio[1328]: amixer -c 0 info | grep "bcm2835 ALSA"
Mar 24 12:07:11 volumio 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.
Mar 24 12:07:11 volumio 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.
Mar 24 12:07:11 volumio 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.
Mar 24 12:07:11 volumio 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.
Mar 24 12:07:11 volumio 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.
Mar 24 12:07:11 volumio 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.
Mar 24 12:07:11 volumio 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.
Mar 24 12:07:11 volumio 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.
Mar 24 12:07:11 volumio sudo[1851]: pam_unix(sudo:session): session closed for user root
Mar 24 12:07:12 volumio volumio[1328]: amixer -c 1 info | grep "bcm2835 Headphones"
Mar 24 12:07:12 volumio volumio[1328]: Card sysdefault:1 'Headphones'/'bcm2835 Headphones'
Mar 24 12:07:12 volumio volumio[1328]: amixer -c 2 info | grep "vc4-hdmi-0"
Mar 24 12:07:12 volumio volumio[1328]: Card sysdefault:2 'vc4hdmi0'/'vc4-hdmi-0'
Mar 24 12:07:12 volumio volumio[1328]: amixer -c 3 info | grep "vc4-hdmi-1"
Mar 24 12:07:12 volumio volumio[1328]: Card sysdefault:3 'vc4hdmi1'/'vc4-hdmi-1'
Mar 24 12:07:12 volumio volumio[1328]: info: Updating MyVolumio device info
Mar 24 12:07:12 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 24 12:07:12 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 24 12:07:12 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 24 12:07:12 volumio volumio[1328]: info: Successfully Added MyVolumio device
Mar 24 12:07:13 volumio volumio[1328]: error: Cannot read Audio Device Capabilities Command failed: /usr/local/bin/alsacap -C 4
Mar 24 12:07:13 volumio volumio[1328]: /bin/sh: 1: /usr/local/bin/alsacap: not found
Mar 24 12:07:13 volumio volumio[1328]: {"cmd":"/usr/local/bin/alsacap -C 4","code":127,"killed":false,"signal":null,"stack":"Error: Command failed: /usr/local/bin/alsacap -C 4\n/bin/sh: 1: /usr/local/bin/alsacap: not found\n\n at ChildProcess.exithandler (node:child_process:421:12)\n at ChildProcess.emit (node:events:514:28)\n at maybeClose (node:internal/child_process:1105:16)\n at Socket. (node:internal/child_process:457:11)\n at Socket.emit (node:events:514:28)\n at Pipe. (node:net:337:12)"}
Mar 24 12:07:13 volumio volumio[1328]: amixer -c 4 info | grep "I-Sabre Q2M DAC"
Mar 24 12:07:13 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
Mar 24 12:07:13 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
Mar 24 12:07:13 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000022] -121
Mar 24 12:07:13 volumio volumio[1328]: Card sysdefault:4 'DAC'/'I-Sabre Q2M DAC'
Mar 24 12:07:13 volumio volumio[1328]: error: Cannot read Audio Device Capabilities Command failed: /usr/local/bin/alsacap -C 4
Mar 24 12:07:13 volumio volumio[1328]: /bin/sh: 1: /usr/local/bin/alsacap: not found
Mar 24 12:07:13 volumio volumio[1328]: {"cmd":"/usr/local/bin/alsacap -C 4","code":127,"killed":false,"signal":null,"stack":"Error: Command failed: /usr/local/bin/alsacap -C 4\n/bin/sh: 1: /usr/local/bin/alsacap: not found\n\n at ChildProcess.exithandler (node:child_process:421:12)\n at ChildProcess.emit (node:events:514:28)\n at maybeClose (node:internal/child_process:1105:16)\n at Socket. (node:internal/child_process:457:11)\n at Socket.emit (node:events:514:28)\n at Pipe. (node:net:337:12)"}
Mar 24 12:07:13 volumio volumio[1328]: amixer -c 4 info | grep "Audiophonics I-Sabre ES9028Q2M"
Mar 24 12:07:13 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
Mar 24 12:07:13 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
Mar 24 12:07:13 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000022] -121
Mar 24 12:07:13 volumio volumio5-onboarding[1643]: time=2026-03-24T12:07:13.604+01:00 level=INFO msg="emitting audio outputs changed event" component=server peer="192.168.1.207:52766 @ 0x2cc5140" selectedOutputId=4
Mar 24 12:07:13 volumio volumio[1328]: info: Remote SSH Stopped
Mar 24 12:07:13 volumio volumio[1328]: info: Successfully Updated MyVolumio device
Mar 24 12:07:14 volumio volumio[1328]: info: Received Get System Info
Mar 24 12:07:14 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 24 12:07:14 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 24 12:07:14 volumio volumio[1328]: info: Discovery: Getting this device information
Mar 24 12:07:14 volumio volumio[1328]: info: CoreCommandRouter::volumioGetState
Mar 24 12:07:14 volumio volumio[1328]: info: CorePlayQueue::getTrack 0
Mar 24 12:07:14 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 24 12:07:14 volumio volumio5-onboarding[1643]: time=2026-03-24T12:07:14.214+01:00 level=INFO msg="emitting software info changed event" component=server peer="192.168.1.207:52766 @ 0x2cc5140" currentVersion=4.103 latestVersion=4.103
Mar 24 12:07:14 volumio volumio5-onboarding[1643]: time=2026-03-24T12:07:14.215+01:00 level=INFO msg="emitting software update progress event" component=server peer="192.168.1.207:52766 @ 0x2cc5140" status=UPDATE_STATUS_NONE progress=0
Mar 24 12:07:14 volumio volumio5-onboarding[1643]: time=2026-03-24T12:07:14.216+01:00 level=INFO msg="emitting user changed event" component=server peer="192.168.1.207:52766 @ 0x2cc5140" userId=
Mar 24 12:07:14 volumio volumio5-onboarding[1643]: time=2026-03-24T12:07:14.216+01:00 level=INFO msg="emitting music providers changed event" component=server peer="192.168.1.207:52766 @ 0x2cc5140" providers=3
Mar 24 12:07:14 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Mar 24 12:07:14 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Mar 24 12:07:14 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Mar 24 12:07:15 volumio bluealsa[1070]: bluez.c:1393: Signal: org.freedesktop.DBus.ObjectManager.InterfacesRemoved(/org/bluez/hci0/dev_5F_CA_88_62_FF_C4, ...)
Mar 24 12:07:16 volumio volumio5-onboarding[1643]: time=2026-03-24T12:07:16.394+01:00 level=INFO msg="emitting plugins changed event" component=server peer="192.168.1.207:52766 @ 0x2cc5140" plugins=62
Mar 24 12:07:16 volumio volumio[1328]: info: CoreCommandRouter::volumioGetState
Mar 24 12:07:16 volumio volumio[1328]: info: CorePlayQueue::getTrack 0
Mar 24 12:07:16 volumio volumio5-onboarding[1643]: time=2026-03-24T12:07:16.441+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.207:52766 @ 0x2cc5140" state=STATUS_STOPPED positionMs=0 volume=100
Mar 24 12:07:16 volumio volumio5-onboarding[1643]: time=2026-03-24T12:07:16.442+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.207:52766 @ 0x2cc5140" id= title=
Mar 24 12:07:16 volumio volumio5-onboarding[1643]: time=2026-03-24T12:07:16.461+01:00 level=INFO msg="navigate to next page" component=server type=REQUEST_TYPE_CONTINUE_NAVIGATION peer="192.168.1.207:52766 @ 0x2cc5140" latency=334.195971ms timeout=10s from=APP_PAGE_ROOT to=APP_PAGE_LEGACY_DEVICE
Mar 24 12:07:16 volumio bluealsa[1070]: bluez.c:1290: Signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded(/org/bluez/hci0/dev_53_63_8B_4B_90_7F, ...)
Mar 24 12:07:17 volumio sudo[1889]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Mar 24 12:07:17 volumio sudo[1889]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Mar 24 12:07:17 volumio sudo[1889]: pam_unix(sudo:session): session closed for user root
Mar 24 12:07:17 volumio sudo[1892]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Mar 24 12:07:17 volumio sudo[1892]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Mar 24 12:07:17 volumio sudo[1892]: pam_unix(sudo:session): session closed for user root
Mar 24 12:07:17 volumio volumio[1328]: verbose: New Socket.io Connection to 192.168.1.41 from 192.168.1.207 UA: Mozilla/5.0 (Linux; Android 16; SM-S936B Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/146.0.7680.119 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6
Mar 24 12:07:18 volumio sudo[1895]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Mar 24 12:07:18 volumio sudo[1895]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Mar 24 12:07:18 volumio sudo[1895]: pam_unix(sudo:session): session closed for user root
Mar 24 12:07:18 volumio sudo[1897]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Mar 24 12:07:18 volumio sudo[1897]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Mar 24 12:07:18 volumio sudo[1897]: pam_unix(sudo:session): session closed for user root
Mar 24 12:07:18 volumio volumio[1328]: verbose: New Socket.io Connection to 192.168.1.41 from 192.168.1.207 UA: Mozilla/5.0 (Linux; Android 16; SM-S936B Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/146.0.7680.119 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6
Mar 24 12:07:18 volumio volumio[1328]: info: CoreCommandRouter::volumioGetState
Mar 24 12:07:18 volumio volumio[1328]: info: CorePlayQueue::getTrack 0
Mar 24 12:07:18 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Mar 24 12:07:18 volumio volumio[1328]: info: Listing playlists
Mar 24 12:07:18 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Mar 24 12:07:18 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Mar 24 12:07:18 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Mar 24 12:07:18 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Mar 24 12:07:20 volumio bluealsa[1070]: bluez.c:1393: Signal: org.freedesktop.DBus.ObjectManager.InterfacesRemoved(/org/bluez/hci0/dev_6A_62_D2_B6_28_BF, ...)
Mar 24 12:07:22 volumio volumio[1328]: info: CoreCommandRouter::volumioGetQueue
Mar 24 12:07:22 volumio volumio[1328]: info: CoreStateMachine::getQueue
Mar 24 12:07:22 volumio volumio[1328]: info: CorePlayQueue::getQueue
Mar 24 12:07:24 volumio bluealsa[1070]: bluez.c:1290: Signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded(/org/bluez/hci0/dev_59_3B_5C_D7_2B_38, ...)
Mar 24 12:07:25 volumio volumio[1328]: error: MyVolumio Plugin failed to authenticate in a timely fashion
Mar 24 12:07:25 volumio volumio[1328]: info: Completed starting MyVolumio Plugin
Mar 24 12:07:25 volumio volumio[1328]: [Metrics] CommandRouter: 93s 769.02ms
Mar 24 12:07:25 volumio volumio[1328]: info: CoreCommandRouter::volumiosetStartupVolume
Mar 24 12:07:25 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 24 12:07:25 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 24 12:07:25 volumio volumio[1328]: info: CoreCommandRouter::Close All Modals sent
Mar 24 12:07:25 volumio volumio[1328]: info: CoreCommandRouter::Close All Modals sent
Mar 24 12:07:25 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
Mar 24 12:07:25 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Mar 24 12:07:25 volumio volumio[1328]: info: Received Get System Info
Mar 24 12:07:25 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 24 12:07:25 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 24 12:07:25 volumio volumio[1328]: info: Discovery: Getting this device information
Mar 24 12:07:25 volumio volumio[1328]: info: CoreCommandRouter::volumioGetState
Mar 24 12:07:25 volumio volumio[1328]: info: CorePlayQueue::getTrack 0
Mar 24 12:07:25 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 24 12:07:26 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Mar 24 12:07:26 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Mar 24 12:07:26 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Mar 24 12:07:27 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Mar 24 12:07:27 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Mar 24 12:07:28 volumio bluealsa[1070]: bluez.c:1393: Signal: org.freedesktop.DBus.ObjectManager.InterfacesRemoved(/org/bluez/hci0/dev_6D_9B_65_05_DB_9C, ...)
Mar 24 12:07:30 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
Mar 24 12:07:32 volumio volumio[1328]: info: BOOT COMPLETED
Mar 24 12:07:36 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Mar 24 12:07:36 volumio volumio[1328]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Mar 24 12:07:36 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Mar 24 12:07:36 volumio volumio[1328]: info: Received Get System Version
Mar 24 12:07:36 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Mar 24 12:07:36 volumio volumio[1328]: info: Received Get System Info
Mar 24 12:07:36 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 24 12:07:36 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 24 12:07:36 volumio volumio[1328]: info: Discovery: Getting this device information
Mar 24 12:07:36 volumio volumio[1328]: info: CoreCommandRouter::volumioGetState
Mar 24 12:07:36 volumio volumio[1328]: info: CorePlayQueue::getTrack 0
Mar 24 12:07:36 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 24 12:07:37 volumio volumio[1328]: info: Enabling plugin touch_display
Mar 24 12:07:37 volumio volumio[1328]: info: Loading plugin "touch_display"...
Mar 24 12:07:37 volumio volumio[1328]: info: Applying required configuration parameters for plugin touch_display
Mar 24 12:07:37 volumio volumio[1328]: info: PLUGIN START: touch_display
Mar 24 12:07:37 volumio volumio[1328]: info: Loading i18n strings for locale nl
Mar 24 12:07:37 volumio volumio[1328]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found.
Mar 24 12:07:37 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Mar 24 12:07:38 volumio sudo[1936]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/mkdir -p /data/volumiokioskextensions/IframeKeyboardBridge
Mar 24 12:07:38 volumio sudo[1936]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Mar 24 12:07:38 volumio volumio[1328]: info: touch_display: No backlight interface detected.
Mar 24 12:07:38 volumio sudo[1936]: pam_unix(sudo:session): session closed for user root
Mar 24 12:07:38 volumio sudo[1938]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service
Mar 24 12:07:38 volumio sudo[1940]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service
Mar 24 12:07:38 volumio sudo[1938]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Mar 24 12:07:38 volumio sudo[1940]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Mar 24 12:07:38 volumio sudo[1943]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload
Mar 24 12:07:38 volumio sudo[1943]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Mar 24 12:07:38 volumio volumio[1328]: info: touch_display: No Raspberry Pi Foundation touch screen detected.
Mar 24 12:07:38 volumio sudo[1938]: pam_unix(sudo:session): session closed for user root
Mar 24 12:07:38 volumio sudo[1947]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/cp -r /data/plugins/user_interface/touch_display/iframe_keyboard_bridge/content.js /data/plugins/user_interface/touch_display/iframe_keyboard_bridge/manifest.json /data/volumiokioskextensions/IframeKeyboardBridge/
Mar 24 12:07:38 volumio sudo[1947]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Mar 24 12:07:38 volumio volumio[1328]: info: touch_display: systemctl stop getty@tty1.service succeeded.
Mar 24 12:07:38 volumio systemd[1]: Reloading.
Mar 24 12:07:38 volumio sudo[1947]: pam_unix(sudo:session): session closed for user root
Mar 24 12:07:38 volumio volumio[1328]: info: touch_display: IframeKeyboardBridge extension installed successfully
Mar 24 12:07:38 volumio sudo[1951]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf
Mar 24 12:07:38 volumio sudo[1951]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Mar 24 12:07:38 volumio sudo[1951]: pam_unix(sudo:session): session closed for user root
Mar 24 12:07:38 volumio volumio[1328]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set.
Mar 24 12:07:39 volumio bluealsa[1070]: bluez.c:1393: Signal: org.freedesktop.DBus.ObjectManager.InterfacesRemoved(/org/bluez/hci0/dev_4D_B6_A8_CA_A8_48, ...)
Mar 24 12:07:40 volumio systemd[1]: Reloading.
Mar 24 12:07:40 volumio sudo[1940]: pam_unix(sudo:session): session closed for user root
Mar 24 12:07:40 volumio volumio[1328]: info: Enabling plugin touch_display
Mar 24 12:07:40 volumio volumio[1328]: info: Loading plugin "touch_display"...
Mar 24 12:07:40 volumio volumio[1328]: info: Applying required configuration parameters for plugin touch_display
Mar 24 12:07:40 volumio volumio[1328]: info: PLUGIN START: touch_display
Mar 24 12:07:41 volumio volumio[1328]: info: Loading i18n strings for locale nl
Mar 24 12:07:41 volumio volumio[1328]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found.
Mar 24 12:07:41 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Mar 24 12:07:41 volumio sudo[2004]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/mkdir -p /data/volumiokioskextensions/IframeKeyboardBridge
Mar 24 12:07:41 volumio sudo[2004]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Mar 24 12:07:41 volumio sudo[2004]: pam_unix(sudo:session): session closed for user root
Mar 24 12:07:41 volumio sudo[2006]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service
Mar 24 12:07:41 volumio sudo[2006]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Mar 24 12:07:41 volumio volumio[1328]: info: touch_display: No backlight interface detected.
Mar 24 12:07:41 volumio sudo[2009]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service
Mar 24 12:07:41 volumio sudo[2009]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Mar 24 12:07:41 volumio volumio[1328]: info: touch_display: systemctl disable getty@tty1.service succeeded.
Mar 24 12:07:42 volumio sudo[2012]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload
Mar 24 12:07:42 volumio sudo[2012]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Mar 24 12:07:42 volumio sudo[2016]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/cp -r /data/plugins/user_interface/touch_display/iframe_keyboard_bridge/content.js /data/plugins/user_interface/touch_display/iframe_keyboard_bridge/manifest.json /data/volumiokioskextensions/IframeKeyboardBridge/
Mar 24 12:07:42 volumio volumio[1328]: info: touch_display: No Raspberry Pi Foundation touch screen detected.
Mar 24 12:07:42 volumio sudo[2016]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Mar 24 12:07:42 volumio sudo[2016]: pam_unix(sudo:session): session closed for user root
Mar 24 12:07:42 volumio volumio[1328]: info: touch_display: IframeKeyboardBridge extension installed successfully
Mar 24 12:07:42 volumio sudo[2019]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf
Mar 24 12:07:42 volumio sudo[2019]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Mar 24 12:07:42 volumio sudo[2019]: pam_unix(sudo:session): session closed for user root
Mar 24 12:07:42 volumio volumio[1328]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set.
Mar 24 12:07:42 volumio sudo[1943]: pam_unix(sudo:session): session closed for user root
Mar 24 12:07:42 volumio volumio[1328]: info: touch_display: systemctl daemon-reload succeeded.
Mar 24 12:07:43 volumio systemd[1]: Reloading.
Mar 24 12:07:43 volumio sudo[2023]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service
Mar 24 12:07:43 volumio sudo[2023]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Mar 24 12:07:44 volumio volumio[1328]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 24 12:07:44 volumio volumio[1328]: info: touch_display: About to detect HDMI ports...
Mar 24 12:07:44 volumio volumio[1328]: info: touch_display: X server not ready, cannot detect HDMI ports yet.
Mar 24 12:07:45 volumio bluealsa[1070]: bluez.c:1393: Signal: org.freedesktop.DBus.ObjectManager.InterfacesRemoved(/org/bluez/hci0/dev_71_B3_0B_DD_66_21, ...)
Mar 24 12:07:45 volumio systemd[1]: Reloading.
Mar 24 12:07:45 volumio sudo[2009]: pam_unix(sudo:session): session closed for user root
Mar 24 12:07:45 volumio volumio[1328]: info: touch_display: systemctl disable getty@tty1.service succeeded.
Mar 24 12:07:47 volumio sudo[2023]: pam_unix(sudo:session): session closed for user root
Mar 24 12:07:47 volumio volumio[1328]: error: touch_display: Failed to start volumio-kiosk.service: Error: Command failed: /usr/bin/sudo /bin/systemctl start volumio-kiosk.service
Mar 24 12:07:47 volumio volumio[1328]: Failed to start volumio-kiosk.service: Unit volumio-kiosk.service not found.
Mar 24 12:07:47 volumio sudo[2012]: pam_unix(sudo:session): session closed for user root
Mar 24 12:07:47 volumio volumio[1328]: info: Error: Error
Mar 24 12:07:47 volumio volumio[1328]: info: touch_display: systemctl daemon-reload succeeded.
Mar 24 12:07:47 volumio sudo[2006]: pam_unix(sudo:session): session closed for user root
Mar 24 12:07:47 volumio volumio[1328]: info: touch_display: systemctl stop getty@tty1.service succeeded.
Mar 24 12:07:47 volumio sudo[2060]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service
Mar 24 12:07:47 volumio sudo[2060]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Mar 24 12:07:47 volumio sudo[2060]: pam_unix(sudo:session): session closed for user root
Mar 24 12:07:47 volumio volumio[1328]: error: touch_display: Failed to start volumio-kiosk.service: Error: Command failed: /usr/bin/sudo /bin/systemctl start volumio-kiosk.service
Mar 24 12:07:47 volumio volumio[1328]: Failed to start volumio-kiosk.service: Unit volumio-kiosk.service not found.
Mar 24 12:07:47 volumio volumio[1328]: info: Error: Error
Mar 24 12:07:51 volumio bluealsa[1070]: bluez.c:1393: Signal: org.freedesktop.DBus.ObjectManager.InterfacesRemoved(/org/bluez/hci0/dev_53_63_8B_4B_90_7F, ...)
Mar 24 12:07:53 volumio volumio[1328]: info: CALLMETHOD: user_interface touch_display saveScreensaverConf [object Object]
Mar 24 12:07:53 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: touch_display , saveScreensaverConf
Mar 24 12:07:55 volumio volumio[1328]: info: CALLMETHOD: user_interface touch_display saveOrientationConf [object Object]
Mar 24 12:07:56 volumio volumio[1328]: info: CoreCommandRouter::executeOnPlugin: touch_display , saveOrientationConf
Mar 24 12:07:56 volumio sudo[2078]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/95-touch_display-plugin.conf
Mar 24 12:07:56 volumio sudo[2078]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Mar 24 12:07:56 volumio sudo[2078]: pam_unix(sudo:session): session closed for user root
Mar 24 12:07:56 volumio volumio[1328]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/95-touch_display-plugin.conf set.
Mar 24 12:07:56 volumio volumio[1328]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Mar 24 12:07:56 volumio volumio[1328]: TypeError: Cannot read properties of undefined (reading 'split')
Mar 24 12:07:56 volumio volumio[1328]: at /data/plugins/user_interface/touch_display/index.js:1298:37
Mar 24 12:07:56 volumio volumio[1328]: at ChildProcess.exithandler (node:child_process:413:7)
Mar 24 12:07:56 volumio volumio[1328]: at ChildProcess.emit (node:events:514:28)
Mar 24 12:07:56 volumio volumio[1328]: at maybeClose (node:internal/child_process:1105:16)
Mar 24 12:07:56 volumio volumio[1328]: at ChildProcess._handle.onexit (node:internal/child_process:305:5)
Mar 24 12:07:56 volumio volumio[1328]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Mar 24 12:07:59 volumio bluealsa[1070]: bluez.c:1393: Signal: org.freedesktop.DBus.ObjectManager.InterfacesRemoved(/org/bluez/hci0/dev_59_3B_5C_D7_2B_38, ...)
Mar 24 12:08:03 volumio sudo[2108]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-03-24 12:07'
Mar 24 12:08:03 volumio sudo[2108]: 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="dc61260dec5515dafd2b634881860b4c46c919ff"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri Mar 6 16:46:58 UTC 2026"
VOLUMIO_VERSION="4.103"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="aa741395b8bfc648ff5d04e312f53d2c"